{"level":"warn","ts":"2026-06-17T02:45:26.417816Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-17T02:45:26.417892Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.229:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.229:2380","--initial-cluster=instance=https://199.204.45.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.229:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-17T02:45:26.417952Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-17T02:45:26.417961Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-06-17T02:45:26.417981Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-17T02:45:26.418545Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"]} {"level":"info","ts":"2026-06-17T02:45:26.41862Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.229:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-17T02:45:26.420976Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.094638ms"} {"level":"info","ts":"2026-06-17T02:45:26.425534Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"} {"level":"info","ts":"2026-06-17T02:45:26.425611Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"} {"level":"info","ts":"2026-06-17T02:45:26.425633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"} {"level":"info","ts":"2026-06-17T02:45:26.42565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ba9ae53cc4335db [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-17T02:45:26.425667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"} {"level":"info","ts":"2026-06-17T02:45:26.425702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"warn","ts":"2026-06-17T02:45:26.430221Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-17T02:45:26.431731Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-17T02:45:26.434536Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-17T02:45:26.437419Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ba9ae53cc4335db","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-17T02:45:26.43805Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ba9ae53cc4335db","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-17T02:45:26.43821Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-17T02:45:26.438288Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-17T02:45:26.438316Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-17T02:45:26.438791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"info","ts":"2026-06-17T02:45:26.442565Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","added-peer-id":"3ba9ae53cc4335db","added-peer-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-06-17T02:45:26.444394Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-17T02:45:26.44462Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ba9ae53cc4335db","initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-17T02:45:26.444652Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-17T02:45:26.444771Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-06-17T02:45:26.444783Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-06-17T02:45:27.026475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"} {"level":"info","ts":"2026-06-17T02:45:27.02654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"} {"level":"info","ts":"2026-06-17T02:45:27.026556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"} {"level":"info","ts":"2026-06-17T02:45:27.026569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"} {"level":"info","ts":"2026-06-17T02:45:27.026574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-06-17T02:45:27.026582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"} {"level":"info","ts":"2026-06-17T02:45:27.02659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-06-17T02:45:27.034853Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T02:45:27.044277Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-17T02:45:27.044275Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ba9ae53cc4335db","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.229:2379]}","request-path":"/0/members/3ba9ae53cc4335db/attributes","cluster-id":"4ad2674607ff1d60","publish-timeout":"7s"} {"level":"info","ts":"2026-06-17T02:45:27.044532Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-17T02:45:27.044666Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-17T02:45:27.044716Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-17T02:45:27.044735Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T02:45:27.044793Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T02:45:27.04486Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-17T02:45:27.046366Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"} {"level":"info","ts":"2026-06-17T02:45:27.047637Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-17T02:45:51.583698Z","caller":"traceutil/trace.go:171","msg":"trace[1773376761] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"145.768645ms","start":"2026-06-17T02:45:51.437897Z","end":"2026-06-17T02:45:51.583666Z","steps":["trace[1773376761] 'process raft request' (duration: 145.592511ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:46:03.249304Z","caller":"traceutil/trace.go:171","msg":"trace[2143347378] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"178.066744ms","start":"2026-06-17T02:46:03.071214Z","end":"2026-06-17T02:46:03.249281Z","steps":["trace[2143347378] 'process raft request' (duration: 177.940701ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:46:03.255081Z","caller":"traceutil/trace.go:171","msg":"trace[784763848] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"181.059242ms","start":"2026-06-17T02:46:03.073996Z","end":"2026-06-17T02:46:03.255055Z","steps":["trace[784763848] 'process raft request' (duration: 180.838707ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:46:03.255168Z","caller":"traceutil/trace.go:171","msg":"trace[1367183979] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"159.159672ms","start":"2026-06-17T02:46:03.095988Z","end":"2026-06-17T02:46:03.255147Z","steps":["trace[1367183979] 'process raft request' (duration: 159.026689ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:46:03.255214Z","caller":"traceutil/trace.go:171","msg":"trace[820643734] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"166.431379ms","start":"2026-06-17T02:46:03.08873Z","end":"2026-06-17T02:46:03.255161Z","steps":["trace[820643734] 'process raft request' (duration: 166.230514ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:46:03.255374Z","caller":"traceutil/trace.go:171","msg":"trace[369949349] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"155.786406ms","start":"2026-06-17T02:46:03.099568Z","end":"2026-06-17T02:46:03.255354Z","steps":["trace[369949349] 'process raft request' (duration: 155.522039ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:46:03.255506Z","caller":"traceutil/trace.go:171","msg":"trace[343872055] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"155.232764ms","start":"2026-06-17T02:46:03.100261Z","end":"2026-06-17T02:46:03.255494Z","steps":["trace[343872055] 'process raft request' (duration: 155.023519ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:46:03.255616Z","caller":"traceutil/trace.go:171","msg":"trace[1077096955] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"154.972188ms","start":"2026-06-17T02:46:03.10063Z","end":"2026-06-17T02:46:03.255602Z","steps":["trace[1077096955] 'process raft request' (duration: 154.722342ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:46:09.631546Z","caller":"traceutil/trace.go:171","msg":"trace[1229076753] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"220.526024ms","start":"2026-06-17T02:46:09.410996Z","end":"2026-06-17T02:46:09.631522Z","steps":["trace[1229076753] 'process raft request' (duration: 219.831848ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:46:10.018152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.440883ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T02:46:10.018357Z","caller":"traceutil/trace.go:171","msg":"trace[210810334] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:632; }","duration":"245.647698ms","start":"2026-06-17T02:46:09.772661Z","end":"2026-06-17T02:46:10.018309Z","steps":["trace[210810334] 'range keys from in-memory index tree' (duration: 245.420902ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:46:10.018983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.814023ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T02:46:10.019175Z","caller":"traceutil/trace.go:171","msg":"trace[1374046087] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:656; }","duration":"282.362685ms","start":"2026-06-17T02:46:09.736797Z","end":"2026-06-17T02:46:10.01916Z","steps":["trace[1374046087] 'read index received' (duration: 144.758624ms)","trace[1374046087] 'applied index is now lower than readState.Index' (duration: 137.603121ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T02:46:10.019359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.56621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9m9fx\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-17T02:46:10.01939Z","caller":"traceutil/trace.go:171","msg":"trace[652053503] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9m9fx; range_end:; response_count:1; response_revision:634; }","duration":"282.598871ms","start":"2026-06-17T02:46:09.736782Z","end":"2026-06-17T02:46:10.019381Z","steps":["trace[652053503] 'agreement among raft nodes before linearized reading' (duration: 282.423717ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:46:10.019398Z","caller":"traceutil/trace.go:171","msg":"trace[1109776951] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"329.319128ms","start":"2026-06-17T02:46:09.690046Z","end":"2026-06-17T02:46:10.019365Z","steps":["trace[1109776951] 'process raft request' (duration: 191.524173ms)","trace[1109776951] 'compare' (duration: 136.626549ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T02:46:10.019546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:46:09.690035Z","time spent":"329.42597ms","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T02:46:10.019695Z","caller":"traceutil/trace.go:171","msg":"trace[1203584712] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"306.061106ms","start":"2026-06-17T02:46:09.713623Z","end":"2026-06-17T02:46:10.019684Z","steps":["trace[1203584712] 'process raft request' (duration: 305.479773ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:46:10.019768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:46:09.713613Z","time spent":"306.118437ms","remote":"127.0.0.1:58442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-17T02:46:10.554937Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870135000669809,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-17T02:46:11.012717Z","caller":"traceutil/trace.go:171","msg":"trace[669680398] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"978.915795ms","start":"2026-06-17T02:46:10.033773Z","end":"2026-06-17T02:46:11.012689Z","steps":["trace[669680398] 'process raft request' (duration: 970.325399ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:46:11.012876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:46:10.033745Z","time spent":"979.058159ms","remote":"127.0.0.1:58142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T02:46:11.030459Z","caller":"traceutil/trace.go:171","msg":"trace[1183388366] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:658; }","duration":"975.971057ms","start":"2026-06-17T02:46:10.054462Z","end":"2026-06-17T02:46:11.030433Z","steps":["trace[1183388366] 'read index received' (duration: 949.710338ms)","trace[1183388366] 'applied index is now lower than readState.Index' (duration: 26.259799ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T02:46:11.030544Z","caller":"traceutil/trace.go:171","msg":"trace[1272577072] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"588.635517ms","start":"2026-06-17T02:46:10.441867Z","end":"2026-06-17T02:46:11.030502Z","steps":["trace[1272577072] 'process raft request' (duration: 588.053063ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:46:11.030621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"929.015267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-17T02:46:11.030663Z","caller":"traceutil/trace.go:171","msg":"trace[388751112] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:636; }","duration":"929.087698ms","start":"2026-06-17T02:46:10.101563Z","end":"2026-06-17T02:46:11.030651Z","steps":["trace[388751112] 'agreement among raft nodes before linearized reading' (duration: 929.000716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:46:11.030666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"976.193923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-17T02:46:11.030705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:46:10.101551Z","time spent":"929.142299ms","remote":"127.0.0.1:57992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.229\" "} {"level":"warn","ts":"2026-06-17T02:46:11.030707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:46:10.441847Z","time spent":"588.777119ms","remote":"127.0.0.1:58044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T02:46:11.030722Z","caller":"traceutil/trace.go:171","msg":"trace[1845786271] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:636; }","duration":"976.284884ms","start":"2026-06-17T02:46:10.054422Z","end":"2026-06-17T02:46:11.030707Z","steps":["trace[1845786271] 'agreement among raft nodes before linearized reading' (duration: 976.11609ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:46:11.030886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:46:10.054405Z","time spent":"976.471979ms","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-17T02:46:11.030904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.072281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-17T02:46:11.030964Z","caller":"traceutil/trace.go:171","msg":"trace[5603921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:636; }","duration":"396.182243ms","start":"2026-06-17T02:46:10.634767Z","end":"2026-06-17T02:46:11.030949Z","steps":["trace[5603921] 'agreement among raft nodes before linearized reading' (duration: 395.990668ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:46:11.031005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:46:10.63472Z","time spent":"396.276166ms","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-17T02:46:26.512985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.283509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-17T02:46:26.513067Z","caller":"traceutil/trace.go:171","msg":"trace[371458513] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:799; }","duration":"132.419723ms","start":"2026-06-17T02:46:26.380631Z","end":"2026-06-17T02:46:26.513051Z","steps":["trace[371458513] 'range keys from in-memory index tree' (duration: 132.074715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:46:26.513217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.069998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-17T02:46:26.513308Z","caller":"traceutil/trace.go:171","msg":"trace[1913944742] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:799; }","duration":"395.271222ms","start":"2026-06-17T02:46:26.118018Z","end":"2026-06-17T02:46:26.513289Z","steps":["trace[1913944742] 'range keys from in-memory index tree' (duration: 394.903274ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:46:26.513358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:46:26.117997Z","time spent":"395.349864ms","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-17T02:46:59.491821Z","caller":"traceutil/trace.go:171","msg":"trace[1175508400] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"233.008868ms","start":"2026-06-17T02:46:59.25879Z","end":"2026-06-17T02:46:59.491799Z","steps":["trace[1175508400] 'process raft request' (duration: 232.902706ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:46:59.492275Z","caller":"traceutil/trace.go:171","msg":"trace[700907987] linearizableReadLoop","detail":"{readStateIndex:1044; appliedIndex:1044; }","duration":"174.441102ms","start":"2026-06-17T02:46:59.317825Z","end":"2026-06-17T02:46:59.492266Z","steps":["trace[700907987] 'read index received' (duration: 174.437692ms)","trace[700907987] 'applied index is now lower than readState.Index' (duration: 2.84µs)"],"step_count":2} {"level":"warn","ts":"2026-06-17T02:46:59.492397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.996175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-17T02:46:59.492417Z","caller":"traceutil/trace.go:171","msg":"trace[1602715666] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1007; }","duration":"172.063697ms","start":"2026-06-17T02:46:59.320348Z","end":"2026-06-17T02:46:59.492411Z","steps":["trace[1602715666] 'agreement among raft nodes before linearized reading' (duration: 171.971695ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:46:59.492547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.732338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-17T02:46:59.492565Z","caller":"traceutil/trace.go:171","msg":"trace[1873788621] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1007; }","duration":"174.784309ms","start":"2026-06-17T02:46:59.317775Z","end":"2026-06-17T02:46:59.49256Z","steps":["trace[1873788621] 'agreement among raft nodes before linearized reading' (duration: 174.732748ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:46:59.786966Z","caller":"traceutil/trace.go:171","msg":"trace[1614469199] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"290.9339ms","start":"2026-06-17T02:46:59.496009Z","end":"2026-06-17T02:46:59.786943Z","steps":["trace[1614469199] 'process raft request' (duration: 250.546839ms)","trace[1614469199] 'compare' (duration: 40.305229ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T02:47:00.198134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.019875ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T02:47:00.198265Z","caller":"traceutil/trace.go:171","msg":"trace[1747388446] linearizableReadLoop","detail":"{readStateIndex:1046; appliedIndex:1044; }","duration":"615.834748ms","start":"2026-06-17T02:46:59.582413Z","end":"2026-06-17T02:47:00.198248Z","steps":["trace[1747388446] 'read index received' (duration: 164.091146ms)","trace[1747388446] 'applied index is now lower than readState.Index' (duration: 451.743032ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T02:47:00.198332Z","caller":"traceutil/trace.go:171","msg":"trace[1387758026] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"702.245759ms","start":"2026-06-17T02:46:59.496079Z","end":"2026-06-17T02:47:00.198324Z","steps":["trace[1387758026] 'process raft request' (duration: 512.973ms)","trace[1387758026] 'compare' (duration: 188.85209ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T02:47:00.198426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:46:59.496063Z","time spent":"702.29286ms","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T02:47:00.198623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.206776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T02:47:00.198655Z","caller":"traceutil/trace.go:171","msg":"trace[2090160097] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1010; }","duration":"616.260947ms","start":"2026-06-17T02:46:59.582385Z","end":"2026-06-17T02:47:00.198645Z","steps":["trace[2090160097] 'agreement among raft nodes before linearized reading' (duration: 616.061452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:47:00.198681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:46:59.582371Z","time spent":"616.304238ms","remote":"127.0.0.1:57976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-17T02:47:00.198825Z","caller":"traceutil/trace.go:171","msg":"trace[948560438] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"187.381906ms","start":"2026-06-17T02:47:00.011412Z","end":"2026-06-17T02:47:00.198794Z","steps":["trace[948560438] 'process raft request' (duration: 186.794693ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:47:27.074365Z","caller":"traceutil/trace.go:171","msg":"trace[2107056447] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"270.765603ms","start":"2026-06-17T02:47:26.803574Z","end":"2026-06-17T02:47:27.07434Z","steps":["trace[2107056447] 'process raft request' (duration: 270.570498ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:47:27.106363Z","caller":"traceutil/trace.go:171","msg":"trace[1395907210] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"301.211499ms","start":"2026-06-17T02:47:26.80512Z","end":"2026-06-17T02:47:27.106332Z","steps":["trace[1395907210] 'process raft request' (duration: 278.907729ms)","trace[1395907210] 'compare' (duration: 22.200058ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T02:47:27.106529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:47:26.8051Z","time spent":"301.342162ms","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T02:47:28.174708Z","caller":"traceutil/trace.go:171","msg":"trace[164843623] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"185.870994ms","start":"2026-06-17T02:47:27.988814Z","end":"2026-06-17T02:47:28.174685Z","steps":["trace[164843623] 'process raft request' (duration: 185.720081ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:47:28.609973Z","caller":"traceutil/trace.go:171","msg":"trace[437758055] linearizableReadLoop","detail":"{readStateIndex:1145; appliedIndex:1144; }","duration":"265.503963ms","start":"2026-06-17T02:47:28.344446Z","end":"2026-06-17T02:47:28.60995Z","steps":["trace[437758055] 'read index received' (duration: 265.258037ms)","trace[437758055] 'applied index is now lower than readState.Index' (duration: 244.956µs)"],"step_count":2} {"level":"info","ts":"2026-06-17T02:47:28.610087Z","caller":"traceutil/trace.go:171","msg":"trace[2028964190] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"314.753358ms","start":"2026-06-17T02:47:28.295324Z","end":"2026-06-17T02:47:28.610077Z","steps":["trace[2028964190] 'process raft request' (duration: 314.455381ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:47:28.610197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:47:28.295281Z","time spent":"314.83569ms","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T02:47:28.61041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.951824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-17T02:47:28.610486Z","caller":"traceutil/trace.go:171","msg":"trace[469208428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1102; }","duration":"266.071777ms","start":"2026-06-17T02:47:28.344397Z","end":"2026-06-17T02:47:28.610469Z","steps":["trace[469208428] 'agreement among raft nodes before linearized reading' (duration: 265.865271ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:47:28.758223Z","caller":"traceutil/trace.go:171","msg":"trace[1882564377] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"143.909996ms","start":"2026-06-17T02:47:28.614279Z","end":"2026-06-17T02:47:28.758189Z","steps":["trace[1882564377] 'process raft request' (duration: 72.043306ms)","trace[1882564377] 'compare' (duration: 71.695456ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T02:48:05.668284Z","caller":"traceutil/trace.go:171","msg":"trace[194247386] linearizableReadLoop","detail":"{readStateIndex:1336; appliedIndex:1335; }","duration":"401.357136ms","start":"2026-06-17T02:48:05.266893Z","end":"2026-06-17T02:48:05.66825Z","steps":["trace[194247386] 'read index received' (duration: 401.163301ms)","trace[194247386] 'applied index is now lower than readState.Index' (duration: 192.725µs)"],"step_count":2} {"level":"info","ts":"2026-06-17T02:48:05.66834Z","caller":"traceutil/trace.go:171","msg":"trace[215754504] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"427.606896ms","start":"2026-06-17T02:48:05.240697Z","end":"2026-06-17T02:48:05.668304Z","steps":["trace[215754504] 'process raft request' (duration: 427.408841ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:48:05.668532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.636802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-17T02:48:05.668573Z","caller":"traceutil/trace.go:171","msg":"trace[2060392577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1283; }","duration":"401.749075ms","start":"2026-06-17T02:48:05.266813Z","end":"2026-06-17T02:48:05.668562Z","steps":["trace[2060392577] 'agreement among raft nodes before linearized reading' (duration: 401.587681ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:48:05.668587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:48:05.240649Z","time spent":"427.773649ms","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T02:48:05.668612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:48:05.26673Z","time spent":"401.874488ms","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-17T02:48:15.120834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.849507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-17T02:48:15.12093Z","caller":"traceutil/trace.go:171","msg":"trace[73738598] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1315; }","duration":"154.98857ms","start":"2026-06-17T02:48:14.965922Z","end":"2026-06-17T02:48:15.120911Z","steps":["trace[73738598] 'range keys from in-memory index tree' (duration: 154.683193ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:48:16.201995Z","caller":"traceutil/trace.go:171","msg":"trace[1011113439] linearizableReadLoop","detail":"{readStateIndex:1374; appliedIndex:1373; }","duration":"273.155417ms","start":"2026-06-17T02:48:15.928824Z","end":"2026-06-17T02:48:16.20198Z","steps":["trace[1011113439] 'read index received' (duration: 272.999193ms)","trace[1011113439] 'applied index is now lower than readState.Index' (duration: 155.724µs)"],"step_count":2} {"level":"info","ts":"2026-06-17T02:48:16.202092Z","caller":"traceutil/trace.go:171","msg":"trace[1229570789] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"340.088468ms","start":"2026-06-17T02:48:15.861973Z","end":"2026-06-17T02:48:16.202062Z","steps":["trace[1229570789] 'process raft request' (duration: 339.895193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:48:16.202142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.309551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-17T02:48:16.202167Z","caller":"traceutil/trace.go:171","msg":"trace[153623115] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1319; }","duration":"273.377412ms","start":"2026-06-17T02:48:15.928783Z","end":"2026-06-17T02:48:16.20216Z","steps":["trace[153623115] 'agreement among raft nodes before linearized reading' (duration: 273.27196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:48:16.202246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:48:15.861956Z","time spent":"340.21053ms","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T02:48:16.362222Z","caller":"traceutil/trace.go:171","msg":"trace[409522558] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"156.3125ms","start":"2026-06-17T02:48:16.205883Z","end":"2026-06-17T02:48:16.362195Z","steps":["trace[409522558] 'process raft request' (duration: 129.413838ms)","trace[409522558] 'compare' (duration: 26.79662ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T02:48:17.661354Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870135000671352,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-17T02:48:17.664645Z","caller":"traceutil/trace.go:171","msg":"trace[1899397595] linearizableReadLoop","detail":"{readStateIndex:1377; appliedIndex:1376; }","duration":"503.834621ms","start":"2026-06-17T02:48:17.160786Z","end":"2026-06-17T02:48:17.664621Z","steps":["trace[1899397595] 'read index received' (duration: 503.648617ms)","trace[1899397595] 'applied index is now lower than readState.Index' (duration: 184.874µs)"],"step_count":2} {"level":"info","ts":"2026-06-17T02:48:17.664801Z","caller":"traceutil/trace.go:171","msg":"trace[1942719751] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"881.98722ms","start":"2026-06-17T02:48:16.782782Z","end":"2026-06-17T02:48:17.66477Z","steps":["trace[1942719751] 'process raft request' (duration: 881.664492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:48:17.664886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.71308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-17T02:48:17.664969Z","caller":"traceutil/trace.go:171","msg":"trace[1878851417] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1322; }","duration":"216.847133ms","start":"2026-06-17T02:48:17.448104Z","end":"2026-06-17T02:48:17.664951Z","steps":["trace[1878851417] 'agreement among raft nodes before linearized reading' (duration: 216.704289ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:48:17.665374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.567449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-17T02:48:17.665433Z","caller":"traceutil/trace.go:171","msg":"trace[37249386] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1322; }","duration":"504.675371ms","start":"2026-06-17T02:48:17.160745Z","end":"2026-06-17T02:48:17.665421Z","steps":["trace[37249386] 'agreement among raft nodes before linearized reading' (duration: 504.047756ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:48:17.66549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:48:17.160728Z","time spent":"504.729102ms","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-17T02:48:17.665918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:48:16.78272Z","time spent":"882.138465ms","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T02:48:18.927534Z","caller":"traceutil/trace.go:171","msg":"trace[1295363178] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"192.802427ms","start":"2026-06-17T02:48:18.734713Z","end":"2026-06-17T02:48:18.927515Z","steps":["trace[1295363178] 'process raft request' (duration: 192.585232ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:51:59.331498Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870135000674247,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-17T02:51:59.832441Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870135000674247,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-17T02:52:00.333415Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870135000674247,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-17T02:52:00.834237Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870135000674247,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-17T02:52:01.334423Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870135000674247,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-17T02:52:01.8348Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870135000674247,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-17T02:52:02.335809Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880870135000674247,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-17T02:52:02.582076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999937113s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-17T02:52:02.582181Z","caller":"traceutil/trace.go:171","msg":"trace[1284351381] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000085697s","start":"2026-06-17T02:52:00.582076Z","end":"2026-06-17T02:52:02.582161Z","steps":["trace[1284351381] 'agreement among raft nodes before linearized reading' (duration: 1.999961484s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:02.582298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:52:00.582053Z","time spent":"2.00023201s","remote":"127.0.0.1:57976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/17 02:52:02 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-17T02:52:02.802295Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.972151652s","expected-duration":"1s"} {"level":"info","ts":"2026-06-17T02:52:02.802908Z","caller":"traceutil/trace.go:171","msg":"trace[1057014630] transaction","detail":"{read_only:false; response_revision:2490; number_of_response:1; }","duration":"3.972819357s","start":"2026-06-17T02:51:58.829977Z","end":"2026-06-17T02:52:02.802796Z","steps":["trace[1057014630] 'process raft request' (duration: 3.972633553s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:02.803119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:51:58.829938Z","time spent":"3.973106364s","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T02:52:03.085358Z","caller":"traceutil/trace.go:171","msg":"trace[1664305178] linearizableReadLoop","detail":"{readStateIndex:2593; appliedIndex:2589; }","duration":"4.254862648s","start":"2026-06-17T02:51:58.830455Z","end":"2026-06-17T02:52:03.085317Z","steps":["trace[1664305178] 'read index received' (duration: 3.972125272s)","trace[1664305178] 'applied index is now lower than readState.Index' (duration: 282.736656ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T02:52:03.085474Z","caller":"traceutil/trace.go:171","msg":"trace[847433048] transaction","detail":"{read_only:false; response_revision:2492; number_of_response:1; }","duration":"2.712120732s","start":"2026-06-17T02:52:00.37333Z","end":"2026-06-17T02:52:03.08545Z","steps":["trace[847433048] 'process raft request' (duration: 2.711895467s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.086011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:52:00.373305Z","time spent":"2.712648265s","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T02:52:03.085984Z","caller":"traceutil/trace.go:171","msg":"trace[1467464119] transaction","detail":"{read_only:false; response_revision:2491; number_of_response:1; }","duration":"2.931017279s","start":"2026-06-17T02:52:00.154938Z","end":"2026-06-17T02:52:03.085956Z","steps":["trace[1467464119] 'process raft request' (duration: 2.885472517s)","trace[1467464119] 'compare' (duration: 44.654692ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T02:52:03.086121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.779712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T02:52:03.086188Z","caller":"traceutil/trace.go:171","msg":"trace[1809763055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2493; }","duration":"503.893455ms","start":"2026-06-17T02:52:02.582278Z","end":"2026-06-17T02:52:03.086172Z","steps":["trace[1809763055] 'agreement among raft nodes before linearized reading' (duration: 503.797031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.086229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:52:02.58226Z","time spent":"503.961077ms","remote":"127.0.0.1:57974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-17T02:52:03.08622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:52:00.154913Z","time spent":"2.931230005s","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T02:52:03.086296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.374797567s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-17T02:52:03.086323Z","caller":"traceutil/trace.go:171","msg":"trace[717092628] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2493; }","duration":"2.374871969s","start":"2026-06-17T02:52:00.711443Z","end":"2026-06-17T02:52:03.086315Z","steps":["trace[717092628] 'agreement among raft nodes before linearized reading' (duration: 2.374581891s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.086347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:52:00.711421Z","time spent":"2.374918089s","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-17T02:52:03.086426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.610459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T02:52:03.086467Z","caller":"traceutil/trace.go:171","msg":"trace[1261305596] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:2493; }","duration":"771.717031ms","start":"2026-06-17T02:52:02.314736Z","end":"2026-06-17T02:52:03.086453Z","steps":["trace[1261305596] 'agreement among raft nodes before linearized reading' (duration: 771.66265ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.086499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:52:02.31471Z","time spent":"771.779123ms","remote":"127.0.0.1:58248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-06-17T02:52:03.086528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.96864837s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-17T02:52:03.086552Z","caller":"traceutil/trace.go:171","msg":"trace[881610400] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:2493; }","duration":"2.968714992s","start":"2026-06-17T02:52:00.117832Z","end":"2026-06-17T02:52:03.086547Z","steps":["trace[881610400] 'agreement among raft nodes before linearized reading' (duration: 2.968649891s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.086571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:52:00.117814Z","time spent":"2.968753322s","remote":"127.0.0.1:57992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.229\" "} {"level":"warn","ts":"2026-06-17T02:52:03.086678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.402535342s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-17T02:52:03.0867Z","caller":"traceutil/trace.go:171","msg":"trace[1283304417] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2493; }","duration":"2.402597363s","start":"2026-06-17T02:52:00.684097Z","end":"2026-06-17T02:52:03.086695Z","steps":["trace[1283304417] 'agreement among raft nodes before linearized reading' (duration: 2.402556162s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.086701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"943.996981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:528"} {"level":"warn","ts":"2026-06-17T02:52:03.086718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:52:00.684076Z","time spent":"2.402637294s","remote":"127.0.0.1:58366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-06-17T02:52:03.086729Z","caller":"traceutil/trace.go:171","msg":"trace[1285275115] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2493; }","duration":"944.061882ms","start":"2026-06-17T02:52:02.142659Z","end":"2026-06-17T02:52:03.086721Z","steps":["trace[1285275115] 'agreement among raft nodes before linearized reading' (duration: 943.95969ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.086796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:52:02.142639Z","time spent":"944.150144ms","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":550,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-17T02:52:03.086812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.662505196s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-17T02:52:03.085953Z","caller":"traceutil/trace.go:171","msg":"trace[1066609158] transaction","detail":"{read_only:false; response_revision:2493; number_of_response:1; }","duration":"2.428495984s","start":"2026-06-17T02:52:00.657436Z","end":"2026-06-17T02:52:03.085932Z","steps":["trace[1066609158] 'process raft request' (duration: 2.427846559s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.086966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:52:00.65741Z","time spent":"2.429513188s","remote":"127.0.0.1:58130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7165,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-17T02:52:03.086902Z","caller":"traceutil/trace.go:171","msg":"trace[1311611622] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2493; }","duration":"1.662630749s","start":"2026-06-17T02:52:01.424254Z","end":"2026-06-17T02:52:03.086885Z","steps":["trace[1311611622] 'agreement among raft nodes before linearized reading' (duration: 1.662407304s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.087026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.194875317s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"} {"level":"info","ts":"2026-06-17T02:52:03.087074Z","caller":"traceutil/trace.go:171","msg":"trace[167467377] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2493; }","duration":"4.195085671s","start":"2026-06-17T02:51:58.891961Z","end":"2026-06-17T02:52:03.087047Z","steps":["trace[167467377] 'agreement among raft nodes before linearized reading' (duration: 4.194047977s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.087101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:51:58.891938Z","time spent":"4.195156783s","remote":"127.0.0.1:58052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":643,"request content":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-17T02:52:03.08717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.662152042s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-17T02:52:03.087218Z","caller":"traceutil/trace.go:171","msg":"trace[1903899463] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2493; }","duration":"3.662237573s","start":"2026-06-17T02:51:59.424974Z","end":"2026-06-17T02:52:03.087211Z","steps":["trace[1903899463] 'agreement among raft nodes before linearized reading' (duration: 3.662146381s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.087243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:51:59.424953Z","time spent":"3.662283605s","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-17T02:52:03.087317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.143376211s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-06-17T02:52:03.087363Z","caller":"traceutil/trace.go:171","msg":"trace[290034323] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2493; }","duration":"1.143457923s","start":"2026-06-17T02:52:01.943889Z","end":"2026-06-17T02:52:03.087347Z","steps":["trace[290034323] 'agreement among raft nodes before linearized reading' (duration: 1.14334166s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.087397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:52:01.943871Z","time spent":"1.143518504s","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":558,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-17T02:52:03.087432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.160430432s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-17T02:52:03.087425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.264042856s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-17T02:52:03.087455Z","caller":"traceutil/trace.go:171","msg":"trace[913074700] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2493; }","duration":"1.160488082s","start":"2026-06-17T02:52:01.926959Z","end":"2026-06-17T02:52:03.087448Z","steps":["trace[913074700] 'agreement among raft nodes before linearized reading' (duration: 1.160421741s)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:03.087468Z","caller":"traceutil/trace.go:171","msg":"trace[359407268] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:2493; }","duration":"3.264120908s","start":"2026-06-17T02:51:59.823338Z","end":"2026-06-17T02:52:03.087459Z","steps":["trace[359407268] 'agreement among raft nodes before linearized reading' (duration: 3.264057216s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.087475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:52:01.92694Z","time spent":"1.160531364s","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-17T02:52:03.087491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:51:59.823317Z","time spent":"3.264168029s","remote":"127.0.0.1:58052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":18,"response size":29,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-06-17T02:52:03.087518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:52:01.424235Z","time spent":"1.662939095s","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-17T02:52:03.086851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.844357668s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-17T02:52:03.087591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.737145846s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-17T02:52:03.087634Z","caller":"traceutil/trace.go:171","msg":"trace[362478659] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2493; }","duration":"3.737214848s","start":"2026-06-17T02:51:59.350412Z","end":"2026-06-17T02:52:03.087627Z","steps":["trace[362478659] 'agreement among raft nodes before linearized reading' (duration: 3.737138067s)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:03.087639Z","caller":"traceutil/trace.go:171","msg":"trace[999215711] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:2493; }","duration":"2.845176096s","start":"2026-06-17T02:52:00.24245Z","end":"2026-06-17T02:52:03.087626Z","steps":["trace[999215711] 'agreement among raft nodes before linearized reading' (duration: 2.844358208s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.087653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:51:59.350396Z","time spent":"3.737251719s","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-17T02:52:03.087678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:52:00.242428Z","time spent":"2.845236827s","remote":"127.0.0.1:58068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-06-17T02:52:03.087973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.257523709s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-17T02:52:03.088015Z","caller":"traceutil/trace.go:171","msg":"trace[27397659] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2493; }","duration":"4.257599171s","start":"2026-06-17T02:51:58.830409Z","end":"2026-06-17T02:52:03.088008Z","steps":["trace[27397659] 'agreement among raft nodes before linearized reading' (duration: 4.255420291s)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.088099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:51:58.830389Z","time spent":"4.257641322s","remote":"127.0.0.1:58196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-17T02:52:03.391398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.815299ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-17T02:52:03.391673Z","caller":"traceutil/trace.go:171","msg":"trace[1985209134] transaction","detail":"{read_only:false; response_revision:2497; number_of_response:1; }","duration":"295.838817ms","start":"2026-06-17T02:52:03.095821Z","end":"2026-06-17T02:52:03.39166Z","steps":["trace[1985209134] 'process raft request' (duration: 295.787986ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:03.391923Z","caller":"traceutil/trace.go:171","msg":"trace[2041730915] transaction","detail":"{read_only:false; response_revision:2496; number_of_response:1; }","duration":"296.38518ms","start":"2026-06-17T02:52:03.09553Z","end":"2026-06-17T02:52:03.391915Z","steps":["trace[2041730915] 'process raft request' (duration: 296.050282ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:03.391974Z","caller":"traceutil/trace.go:171","msg":"trace[1583448779] transaction","detail":"{read_only:false; response_revision:2495; number_of_response:1; }","duration":"296.666056ms","start":"2026-06-17T02:52:03.095254Z","end":"2026-06-17T02:52:03.39192Z","steps":["trace[1583448779] 'process raft request' (duration: 296.278547ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:03.392019Z","caller":"traceutil/trace.go:171","msg":"trace[1607990959] transaction","detail":"{read_only:false; response_revision:2494; number_of_response:1; }","duration":"297.342231ms","start":"2026-06-17T02:52:03.094558Z","end":"2026-06-17T02:52:03.3919Z","steps":["trace[1607990959] 'process raft request' (duration: 166.951389ms)","trace[1607990959] 'compare' (duration: 129.673155ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T02:52:03.392376Z","caller":"traceutil/trace.go:171","msg":"trace[1722622004] transaction","detail":"{read_only:false; response_revision:2498; number_of_response:1; }","duration":"295.483009ms","start":"2026-06-17T02:52:03.09688Z","end":"2026-06-17T02:52:03.392363Z","steps":["trace[1722622004] 'process raft request' (duration: 294.752762ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:03.394385Z","caller":"traceutil/trace.go:171","msg":"trace[1263706899] transaction","detail":"{read_only:false; response_revision:2500; number_of_response:1; }","duration":"297.380983ms","start":"2026-06-17T02:52:03.096988Z","end":"2026-06-17T02:52:03.394369Z","steps":["trace[1263706899] 'process raft request' (duration: 297.28837ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:03.394508Z","caller":"traceutil/trace.go:171","msg":"trace[1332399526] transaction","detail":"{read_only:false; response_revision:2499; number_of_response:1; }","duration":"297.544537ms","start":"2026-06-17T02:52:03.096955Z","end":"2026-06-17T02:52:03.3945Z","steps":["trace[1332399526] 'process raft request' (duration: 295.024609ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:03.394625Z","caller":"traceutil/trace.go:171","msg":"trace[1446656580] transaction","detail":"{read_only:false; response_revision:2501; number_of_response:1; }","duration":"297.26677ms","start":"2026-06-17T02:52:03.097352Z","end":"2026-06-17T02:52:03.394619Z","steps":["trace[1446656580] 'process raft request' (duration: 296.984213ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:03.394838Z","caller":"traceutil/trace.go:171","msg":"trace[403627841] linearizableReadLoop","detail":"{readStateIndex:2596; appliedIndex:2594; }","duration":"299.367207ms","start":"2026-06-17T02:52:03.095463Z","end":"2026-06-17T02:52:03.39483Z","steps":["trace[403627841] 'read index received' (duration: 55.201013ms)","trace[403627841] 'applied index is now lower than readState.Index' (duration: 244.165434ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T02:52:03.394897Z","caller":"traceutil/trace.go:171","msg":"trace[1631559543] transaction","detail":"{read_only:false; response_revision:2502; number_of_response:1; }","duration":"297.202298ms","start":"2026-06-17T02:52:03.09769Z","end":"2026-06-17T02:52:03.394892Z","steps":["trace[1631559543] 'process raft request' (duration: 296.899481ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.3951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.279533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-06-17T02:52:03.395157Z","caller":"traceutil/trace.go:171","msg":"trace[1375349213] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2503; }","duration":"298.359484ms","start":"2026-06-17T02:52:03.096783Z","end":"2026-06-17T02:52:03.395142Z","steps":["trace[1375349213] 'agreement among raft nodes before linearized reading' (duration: 298.217211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.395257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.792317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T02:52:03.39528Z","caller":"traceutil/trace.go:171","msg":"trace[1878268462] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2503; }","duration":"299.825398ms","start":"2026-06-17T02:52:03.095446Z","end":"2026-06-17T02:52:03.395272Z","steps":["trace[1878268462] 'agreement among raft nodes before linearized reading' (duration: 299.502491ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.395391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.396762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1243"} {"level":"info","ts":"2026-06-17T02:52:03.395366Z","caller":"traceutil/trace.go:171","msg":"trace[1257455568] transaction","detail":"{read_only:false; response_revision:2503; number_of_response:1; }","duration":"243.762826ms","start":"2026-06-17T02:52:03.151582Z","end":"2026-06-17T02:52:03.395345Z","steps":["trace[1257455568] 'process raft request' (duration: 243.137542ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:03.395424Z","caller":"traceutil/trace.go:171","msg":"trace[1880085437] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:2503; }","duration":"283.453393ms","start":"2026-06-17T02:52:03.111963Z","end":"2026-06-17T02:52:03.395416Z","steps":["trace[1880085437] 'agreement among raft nodes before linearized reading' (duration: 283.32229ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.74933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.862684ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-17T02:52:03.749444Z","caller":"traceutil/trace.go:171","msg":"trace[15588529] transaction","detail":"{read_only:false; response_revision:2504; number_of_response:1; }","duration":"354.309383ms","start":"2026-06-17T02:52:03.395112Z","end":"2026-06-17T02:52:03.749421Z","steps":["trace[15588529] 'process raft request' (duration: 184.293495ms)","trace[15588529] 'compare' (duration: 169.749762ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T02:52:03.749594Z","caller":"traceutil/trace.go:171","msg":"trace[591957283] transaction","detail":"{read_only:false; response_revision:2505; number_of_response:1; }","duration":"349.7338ms","start":"2026-06-17T02:52:03.399844Z","end":"2026-06-17T02:52:03.749577Z","steps":["trace[591957283] 'process raft request' (duration: 349.583146ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:03.749712Z","caller":"traceutil/trace.go:171","msg":"trace[611671457] linearizableReadLoop","detail":"{readStateIndex:2605; appliedIndex:2604; }","duration":"352.145464ms","start":"2026-06-17T02:52:03.397539Z","end":"2026-06-17T02:52:03.749684Z","steps":["trace[611671457] 'read index received' (duration: 181.88064ms)","trace[611671457] 'applied index is now lower than readState.Index' (duration: 170.261994ms)"],"step_count":2} {"level":"warn","ts":"2026-06-17T02:52:03.749749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:52:03.399822Z","time spent":"349.849982ms","remote":"127.0.0.1:58052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":606,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-17T02:52:03.749966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.40249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:7179"} {"level":"warn","ts":"2026-06-17T02:52:03.750013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.627621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2476"} {"level":"info","ts":"2026-06-17T02:52:03.750018Z","caller":"traceutil/trace.go:171","msg":"trace[1072861102] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:2505; }","duration":"352.486191ms","start":"2026-06-17T02:52:03.39752Z","end":"2026-06-17T02:52:03.750007Z","steps":["trace[1072861102] 'agreement among raft nodes before linearized reading' (duration: 352.299087ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:03.750046Z","caller":"traceutil/trace.go:171","msg":"trace[1201548370] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:2505; }","duration":"156.676843ms","start":"2026-06-17T02:52:03.593359Z","end":"2026-06-17T02:52:03.750036Z","steps":["trace[1201548370] 'agreement among raft nodes before linearized reading' (duration: 156.55702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.750059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:52:03.397511Z","time spent":"352.540322ms","remote":"127.0.0.1:58130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":7201,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-17T02:52:03.750159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.147743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T02:52:03.750269Z","caller":"traceutil/trace.go:171","msg":"trace[1415047761] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2505; }","duration":"167.292477ms","start":"2026-06-17T02:52:03.582956Z","end":"2026-06-17T02:52:03.750249Z","steps":["trace[1415047761] 'agreement among raft nodes before linearized reading' (duration: 167.161444ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.750428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:52:03.395097Z","time spent":"354.437127ms","remote":"127.0.0.1:58014","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":758,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-17T02:52:03.750507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.186714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-06-17T02:52:03.750579Z","caller":"traceutil/trace.go:171","msg":"trace[379300038] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:2505; }","duration":"352.797669ms","start":"2026-06-17T02:52:03.397769Z","end":"2026-06-17T02:52:03.750567Z","steps":["trace[379300038] 'agreement among raft nodes before linearized reading' (duration: 352.131193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:03.751216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-17T02:52:03.397753Z","time spent":"353.444824ms","remote":"127.0.0.1:58120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"info","ts":"2026-06-17T02:52:05.62559Z","caller":"traceutil/trace.go:171","msg":"trace[1673209229] transaction","detail":"{read_only:false; response_revision:2509; number_of_response:1; }","duration":"225.347034ms","start":"2026-06-17T02:52:05.400221Z","end":"2026-06-17T02:52:05.625568Z","steps":["trace[1673209229] 'process raft request' (duration: 225.230641ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:05.638977Z","caller":"traceutil/trace.go:171","msg":"trace[326252644] transaction","detail":"{read_only:false; response_revision:2510; number_of_response:1; }","duration":"237.36303ms","start":"2026-06-17T02:52:05.401592Z","end":"2026-06-17T02:52:05.638955Z","steps":["trace[326252644] 'process raft request' (duration: 237.119194ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:05.639291Z","caller":"traceutil/trace.go:171","msg":"trace[964096754] transaction","detail":"{read_only:false; response_revision:2511; number_of_response:1; }","duration":"237.567884ms","start":"2026-06-17T02:52:05.401711Z","end":"2026-06-17T02:52:05.639278Z","steps":["trace[964096754] 'process raft request' (duration: 237.191265ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:05.639597Z","caller":"traceutil/trace.go:171","msg":"trace[1393215090] transaction","detail":"{read_only:false; response_revision:2512; number_of_response:1; }","duration":"236.897098ms","start":"2026-06-17T02:52:05.402452Z","end":"2026-06-17T02:52:05.639349Z","steps":["trace[1393215090] 'process raft request' (duration: 236.687824ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:06.559296Z","caller":"traceutil/trace.go:171","msg":"trace[1924493217] transaction","detail":"{read_only:false; response_revision:2515; number_of_response:1; }","duration":"184.626653ms","start":"2026-06-17T02:52:06.374646Z","end":"2026-06-17T02:52:06.559273Z","steps":["trace[1924493217] 'process raft request' (duration: 184.443108ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:08.010767Z","caller":"traceutil/trace.go:171","msg":"trace[186888030] transaction","detail":"{read_only:false; response_revision:2519; number_of_response:1; }","duration":"273.173097ms","start":"2026-06-17T02:52:07.737552Z","end":"2026-06-17T02:52:08.010725Z","steps":["trace[186888030] 'process raft request' (duration: 240.951141ms)","trace[186888030] 'compare' (duration: 32.068453ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T02:52:08.011032Z","caller":"traceutil/trace.go:171","msg":"trace[1021404311] transaction","detail":"{read_only:false; response_revision:2520; number_of_response:1; }","duration":"273.434774ms","start":"2026-06-17T02:52:07.737569Z","end":"2026-06-17T02:52:08.011004Z","steps":["trace[1021404311] 'process raft request' (duration: 273.107765ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:08.019562Z","caller":"traceutil/trace.go:171","msg":"trace[2037688422] linearizableReadLoop","detail":"{readStateIndex:2623; appliedIndex:2620; }","duration":"126.156965ms","start":"2026-06-17T02:52:07.893381Z","end":"2026-06-17T02:52:08.019538Z","steps":["trace[2037688422] 'read index received' (duration: 85.125166ms)","trace[2037688422] 'applied index is now lower than readState.Index' (duration: 41.030919ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T02:52:08.019643Z","caller":"traceutil/trace.go:171","msg":"trace[1460737026] transaction","detail":"{read_only:false; response_revision:2521; number_of_response:1; }","duration":"281.472799ms","start":"2026-06-17T02:52:07.738143Z","end":"2026-06-17T02:52:08.019616Z","steps":["trace[1460737026] 'process raft request' (duration: 281.272674ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:08.019781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.320959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-17T02:52:08.019893Z","caller":"traceutil/trace.go:171","msg":"trace[967369245] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:2521; }","duration":"126.515444ms","start":"2026-06-17T02:52:07.893366Z","end":"2026-06-17T02:52:08.019882Z","steps":["trace[967369245] 'agreement among raft nodes before linearized reading' (duration: 126.298039ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:08.244766Z","caller":"traceutil/trace.go:171","msg":"trace[1748409106] transaction","detail":"{read_only:false; response_revision:2523; number_of_response:1; }","duration":"191.52267ms","start":"2026-06-17T02:52:08.053217Z","end":"2026-06-17T02:52:08.24474Z","steps":["trace[1748409106] 'process raft request' (duration: 136.694046ms)","trace[1748409106] 'compare' (duration: 54.548158ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T02:52:08.773459Z","caller":"traceutil/trace.go:171","msg":"trace[1163386653] transaction","detail":"{read_only:false; response_revision:2525; number_of_response:1; }","duration":"274.997239ms","start":"2026-06-17T02:52:08.498441Z","end":"2026-06-17T02:52:08.773438Z","steps":["trace[1163386653] 'process raft request' (duration: 274.843566ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:08.773759Z","caller":"traceutil/trace.go:171","msg":"trace[1674560040] transaction","detail":"{read_only:false; response_revision:2526; number_of_response:1; }","duration":"275.265686ms","start":"2026-06-17T02:52:08.498471Z","end":"2026-06-17T02:52:08.773737Z","steps":["trace[1674560040] 'process raft request' (duration: 274.932499ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:08.774087Z","caller":"traceutil/trace.go:171","msg":"trace[368220436] linearizableReadLoop","detail":"{readStateIndex:2629; appliedIndex:2626; }","duration":"192.232998ms","start":"2026-06-17T02:52:08.581832Z","end":"2026-06-17T02:52:08.774065Z","steps":["trace[368220436] 'read index received' (duration: 191.395539ms)","trace[368220436] 'applied index is now lower than readState.Index' (duration: 835.869µs)"],"step_count":2} {"level":"info","ts":"2026-06-17T02:52:08.774225Z","caller":"traceutil/trace.go:171","msg":"trace[1744189398] transaction","detail":"{read_only:false; response_revision:2527; number_of_response:1; }","duration":"275.491871ms","start":"2026-06-17T02:52:08.498714Z","end":"2026-06-17T02:52:08.774205Z","steps":["trace[1744189398] 'process raft request' (duration: 274.884017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:08.774359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.505224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-17T02:52:08.774423Z","caller":"traceutil/trace.go:171","msg":"trace[1265062041] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2527; }","duration":"192.618855ms","start":"2026-06-17T02:52:08.581792Z","end":"2026-06-17T02:52:08.774411Z","steps":["trace[1265062041] 'agreement among raft nodes before linearized reading' (duration: 192.414851ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:09.354612Z","caller":"traceutil/trace.go:171","msg":"trace[1758693904] transaction","detail":"{read_only:false; response_revision:2529; number_of_response:1; }","duration":"165.871624ms","start":"2026-06-17T02:52:09.188711Z","end":"2026-06-17T02:52:09.354582Z","steps":["trace[1758693904] 'process raft request' (duration: 112.046373ms)","trace[1758693904] 'compare' (duration: 53.649547ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T02:52:10.127306Z","caller":"traceutil/trace.go:171","msg":"trace[1308210129] transaction","detail":"{read_only:false; response_revision:2531; number_of_response:1; }","duration":"108.461191ms","start":"2026-06-17T02:52:10.01882Z","end":"2026-06-17T02:52:10.127282Z","steps":["trace[1308210129] 'process raft request' (duration: 108.323098ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:10.171579Z","caller":"traceutil/trace.go:171","msg":"trace[2065700687] linearizableReadLoop","detail":"{readStateIndex:2634; appliedIndex:2632; }","duration":"148.66999ms","start":"2026-06-17T02:52:10.022885Z","end":"2026-06-17T02:52:10.171555Z","steps":["trace[2065700687] 'read index received' (duration: 104.349787ms)","trace[2065700687] 'applied index is now lower than readState.Index' (duration: 44.318943ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T02:52:10.17163Z","caller":"traceutil/trace.go:171","msg":"trace[1922610477] transaction","detail":"{read_only:false; response_revision:2532; number_of_response:1; }","duration":"151.774771ms","start":"2026-06-17T02:52:10.019827Z","end":"2026-06-17T02:52:10.171601Z","steps":["trace[1922610477] 'process raft request' (duration: 151.621628ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:10.171781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.883135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-17T02:52:10.171822Z","caller":"traceutil/trace.go:171","msg":"trace[1483318950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2532; }","duration":"148.965557ms","start":"2026-06-17T02:52:10.022845Z","end":"2026-06-17T02:52:10.171811Z","steps":["trace[1483318950] 'agreement among raft nodes before linearized reading' (duration: 148.827664ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:10.369695Z","caller":"traceutil/trace.go:171","msg":"trace[687535071] linearizableReadLoop","detail":"{readStateIndex:2636; appliedIndex:2634; }","duration":"121.488848ms","start":"2026-06-17T02:52:10.248187Z","end":"2026-06-17T02:52:10.369676Z","steps":["trace[687535071] 'read index received' (duration: 78.528236ms)","trace[687535071] 'applied index is now lower than readState.Index' (duration: 42.959542ms)"],"step_count":2} {"level":"info","ts":"2026-06-17T02:52:10.369765Z","caller":"traceutil/trace.go:171","msg":"trace[1528563399] transaction","detail":"{read_only:false; response_revision:2533; number_of_response:1; }","duration":"194.54332ms","start":"2026-06-17T02:52:10.175192Z","end":"2026-06-17T02:52:10.369735Z","steps":["trace[1528563399] 'process raft request' (duration: 194.367505ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:10.369878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.682274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"} {"level":"info","ts":"2026-06-17T02:52:10.369922Z","caller":"traceutil/trace.go:171","msg":"trace[2050894612] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2533; }","duration":"121.785446ms","start":"2026-06-17T02:52:10.248125Z","end":"2026-06-17T02:52:10.36991Z","steps":["trace[2050894612] 'agreement among raft nodes before linearized reading' (duration: 121.640543ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:31.680253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.389097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/kubeadm:get-nodes\" ","response":"range_response_count:1 size:469"} {"level":"warn","ts":"2026-06-17T02:52:31.680303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.148401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-envoy-gateway-rolebinding\" ","response":"range_response_count:1 size:842"} {"level":"info","ts":"2026-06-17T02:52:31.680347Z","caller":"traceutil/trace.go:171","msg":"trace[232302905] range","detail":"{range_begin:/registry/clusterrolebindings/kubeadm:get-nodes; range_end:; response_count:1; response_revision:2656; }","duration":"159.53237ms","start":"2026-06-17T02:52:31.520793Z","end":"2026-06-17T02:52:31.680326Z","steps":["trace[232302905] 'range keys from in-memory index tree' (duration: 159.259523ms)"],"step_count":1} {"level":"warn","ts":"2026-06-17T02:52:31.680321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.41459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-17T02:52:31.680457Z","caller":"traceutil/trace.go:171","msg":"trace[1107683988] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:2656; }","duration":"110.602554ms","start":"2026-06-17T02:52:31.569837Z","end":"2026-06-17T02:52:31.680439Z","steps":["trace[1107683988] 'count revisions from in-memory index tree' (duration: 110.319718ms)"],"step_count":1} {"level":"info","ts":"2026-06-17T02:52:31.68038Z","caller":"traceutil/trace.go:171","msg":"trace[299245949] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-envoy-gateway-rolebinding; range_end:; response_count:1; response_revision:2656; }","duration":"159.236433ms","start":"2026-06-17T02:52:31.521124Z","end":"2026-06-17T02:52:31.68036Z","steps":["trace[299245949] 'range keys from in-memory index tree' (duration: 159.010628ms)"],"step_count":1}