{"level":"warn","ts":"2026-03-17T21:55:55.544711Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-17T21:55:55.544795Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.85: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.19.213.85:2380","--initial-cluster=instance=https://199.19.213.85:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.85:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.85: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-03-17T21:55:55.544858Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-17T21:55:55.544869Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.85:2380"]} {"level":"info","ts":"2026-03-17T21:55:55.544886Z","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-03-17T21:55:55.545526Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.85:2379"]} {"level":"info","ts":"2026-03-17T21:55:55.545593Z","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.19.213.85:2380"],"listen-peer-urls":["https://199.19.213.85:2380"],"advertise-client-urls":["https://199.19.213.85:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.85:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.85: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-03-17T21:55:55.548188Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.393076ms"} {"level":"info","ts":"2026-03-17T21:55:55.558074Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6a0c678c4e560a44","cluster-id":"dbaaf49260b7a32b"} {"level":"info","ts":"2026-03-17T21:55:55.558221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 switched to configuration voters=()"} {"level":"info","ts":"2026-03-17T21:55:55.558261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 became follower at term 0"} {"level":"info","ts":"2026-03-17T21:55:55.558277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6a0c678c4e560a44 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-17T21:55:55.558289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 became follower at term 1"} {"level":"info","ts":"2026-03-17T21:55:55.558336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 switched to configuration voters=(7641596520048233028)"} {"level":"warn","ts":"2026-03-17T21:55:55.575607Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-17T21:55:55.578863Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-17T21:55:55.587234Z","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-03-17T21:55:55.589416Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6a0c678c4e560a44","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-17T21:55:55.589525Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6a0c678c4e560a44","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-17T21:55:55.59043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 switched to configuration voters=(7641596520048233028)"} {"level":"info","ts":"2026-03-17T21:55:55.590528Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dbaaf49260b7a32b","local-member-id":"6a0c678c4e560a44","added-peer-id":"6a0c678c4e560a44","added-peer-peer-urls":["https://199.19.213.85:2380"]} {"level":"info","ts":"2026-03-17T21:55:55.590255Z","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-03-17T21:55:55.591706Z","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-03-17T21:55:55.591723Z","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-03-17T21:55:55.595375Z","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-03-17T21:55:55.595485Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.85:2380"} {"level":"info","ts":"2026-03-17T21:55:55.595514Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.85:2380"} {"level":"info","ts":"2026-03-17T21:55:55.596412Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6a0c678c4e560a44","initial-advertise-peer-urls":["https://199.19.213.85:2380"],"listen-peer-urls":["https://199.19.213.85:2380"],"advertise-client-urls":["https://199.19.213.85:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.85:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-17T21:55:55.596441Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-17T21:55:55.959307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 is starting a new election at term 1"} {"level":"info","ts":"2026-03-17T21:55:55.959399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-17T21:55:55.959417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 received MsgPreVoteResp from 6a0c678c4e560a44 at term 1"} {"level":"info","ts":"2026-03-17T21:55:55.959429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 became candidate at term 2"} {"level":"info","ts":"2026-03-17T21:55:55.959451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 received MsgVoteResp from 6a0c678c4e560a44 at term 2"} {"level":"info","ts":"2026-03-17T21:55:55.959471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 became leader at term 2"} {"level":"info","ts":"2026-03-17T21:55:55.959482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6a0c678c4e560a44 elected leader 6a0c678c4e560a44 at term 2"} {"level":"info","ts":"2026-03-17T21:55:55.961712Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-17T21:55:55.963788Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6a0c678c4e560a44","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.85:2379]}","request-path":"/0/members/6a0c678c4e560a44/attributes","cluster-id":"dbaaf49260b7a32b","publish-timeout":"7s"} {"level":"info","ts":"2026-03-17T21:55:55.963811Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-17T21:55:55.964472Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-17T21:55:55.964709Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dbaaf49260b7a32b","local-member-id":"6a0c678c4e560a44","cluster-version":"3.5"} {"level":"info","ts":"2026-03-17T21:55:55.964941Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-17T21:55:55.964959Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-17T21:55:55.965247Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-17T21:55:55.965258Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-17T21:55:55.967082Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-17T21:55:55.974284Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.85:2379"} {"level":"info","ts":"2026-03-17T21:56:21.667443Z","caller":"traceutil/trace.go:171","msg":"trace[461006206] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"453.470317ms","start":"2026-03-17T21:56:21.213945Z","end":"2026-03-17T21:56:21.667415Z","steps":["trace[461006206] 'process raft request' (duration: 453.314063ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:56:21.668104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:56:21.213909Z","time spent":"453.625771ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T21:56:22.145153Z","caller":"traceutil/trace.go:171","msg":"trace[156559570] linearizableReadLoop","detail":"{readStateIndex:443; appliedIndex:441; }","duration":"708.370816ms","start":"2026-03-17T21:56:21.436743Z","end":"2026-03-17T21:56:22.145114Z","steps":["trace[156559570] 'read index received' (duration: 230.524547ms)","trace[156559570] 'applied index is now lower than readState.Index' (duration: 477.844589ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:56:22.145566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.785205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T21:56:22.145645Z","caller":"traceutil/trace.go:171","msg":"trace[348655135] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:428; }","duration":"708.915559ms","start":"2026-03-17T21:56:21.436715Z","end":"2026-03-17T21:56:22.145631Z","steps":["trace[348655135] 'agreement among raft nodes before linearized reading' (duration: 708.779226ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:56:22.145618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.089691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-03-17T21:56:22.145665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.53704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-03-17T21:56:22.145678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:56:21.436705Z","time spent":"708.96639ms","remote":"127.0.0.1:42744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-17T21:56:22.145701Z","caller":"traceutil/trace.go:171","msg":"trace[1154930513] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:428; }","duration":"679.217373ms","start":"2026-03-17T21:56:21.466463Z","end":"2026-03-17T21:56:22.14568Z","steps":["trace[1154930513] 'agreement among raft nodes before linearized reading' (duration: 679.034429ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:56:22.145707Z","caller":"traceutil/trace.go:171","msg":"trace[4428575] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:428; }","duration":"550.630342ms","start":"2026-03-17T21:56:21.595063Z","end":"2026-03-17T21:56:22.145694Z","steps":["trace[4428575] 'agreement among raft nodes before linearized reading' (duration: 550.437608ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:56:22.145742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:56:21.595032Z","time spent":"550.702354ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-17T21:56:22.145792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.94419ms","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-03-17T21:56:22.145823Z","caller":"traceutil/trace.go:171","msg":"trace[290111041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:428; }","duration":"550.983021ms","start":"2026-03-17T21:56:21.594833Z","end":"2026-03-17T21:56:22.145816Z","steps":["trace[290111041] 'agreement among raft nodes before linearized reading' (duration: 550.93028ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:56:22.145745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:56:21.466455Z","time spent":"679.283974ms","remote":"127.0.0.1:34338","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":"info","ts":"2026-03-17T21:56:22.145889Z","caller":"traceutil/trace.go:171","msg":"trace[1659949485] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"838.173065ms","start":"2026-03-17T21:56:21.307702Z","end":"2026-03-17T21:56:22.145875Z","steps":["trace[1659949485] 'process raft request' (duration: 803.38389ms)","trace[1659949485] 'compare' (duration: 33.880513ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:56:22.145926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:56:21.594827Z","time spent":"551.015792ms","remote":"127.0.0.1:34338","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-03-17T21:56:22.145999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:56:21.307658Z","time spent":"838.273847ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T21:56:22.401295Z","caller":"traceutil/trace.go:171","msg":"trace[2014572441] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"251.414196ms","start":"2026-03-17T21:56:22.149849Z","end":"2026-03-17T21:56:22.401263Z","steps":["trace[2014572441] 'process raft request' (duration: 251.1464ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:56:22.401913Z","caller":"traceutil/trace.go:171","msg":"trace[1782409659] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"251.670083ms","start":"2026-03-17T21:56:22.15022Z","end":"2026-03-17T21:56:22.40189Z","steps":["trace[1782409659] 'process raft request' (duration: 251.442847ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:56:22.402112Z","caller":"traceutil/trace.go:171","msg":"trace[516109308] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"251.206632ms","start":"2026-03-17T21:56:22.150634Z","end":"2026-03-17T21:56:22.401841Z","steps":["trace[516109308] 'process raft request' (duration: 251.169351ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:56:27.979753Z","caller":"traceutil/trace.go:171","msg":"trace[1264882119] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:490; }","duration":"104.771703ms","start":"2026-03-17T21:56:27.874947Z","end":"2026-03-17T21:56:27.979719Z","steps":["trace[1264882119] 'read index received' (duration: 104.492326ms)","trace[1264882119] 'applied index is now lower than readState.Index' (duration: 278.037µs)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:56:27.979785Z","caller":"traceutil/trace.go:171","msg":"trace[791666634] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"281.882141ms","start":"2026-03-17T21:56:27.697872Z","end":"2026-03-17T21:56:27.979754Z","steps":["trace[791666634] 'process raft request' (duration: 281.661186ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:56:27.980004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.0332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4419"} {"level":"info","ts":"2026-03-17T21:56:27.98009Z","caller":"traceutil/trace.go:171","msg":"trace[686459015] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:475; }","duration":"105.164882ms","start":"2026-03-17T21:56:27.874902Z","end":"2026-03-17T21:56:27.980067Z","steps":["trace[686459015] 'agreement among raft nodes before linearized reading' (duration: 104.959587ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:56:35.0865Z","caller":"traceutil/trace.go:171","msg":"trace[338346840] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"248.708453ms","start":"2026-03-17T21:56:34.837765Z","end":"2026-03-17T21:56:35.086473Z","steps":["trace[338346840] 'process raft request' (duration: 248.476748ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:56:36.364347Z","caller":"traceutil/trace.go:171","msg":"trace[1540374459] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"353.059617ms","start":"2026-03-17T21:56:36.011259Z","end":"2026-03-17T21:56:36.364318Z","steps":["trace[1540374459] 'process raft request' (duration: 352.834551ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:56:36.364524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:56:36.011232Z","time spent":"353.209189ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T21:56:38.24152Z","caller":"traceutil/trace.go:171","msg":"trace[1046760354] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"163.948499ms","start":"2026-03-17T21:56:38.077544Z","end":"2026-03-17T21:56:38.241493Z","steps":["trace[1046760354] 'process raft request' (duration: 163.827956ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:56:42.832053Z","caller":"traceutil/trace.go:171","msg":"trace[2043637588] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"120.974503ms","start":"2026-03-17T21:56:42.711049Z","end":"2026-03-17T21:56:42.832024Z","steps":["trace[2043637588] 'process raft request' (duration: 49.545511ms)","trace[2043637588] 'compare' (duration: 71.212427ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:56:55.896772Z","caller":"traceutil/trace.go:171","msg":"trace[126023313] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"130.321628ms","start":"2026-03-17T21:56:55.766428Z","end":"2026-03-17T21:56:55.89675Z","steps":["trace[126023313] 'process raft request' (duration: 130.166654ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:57:26.317927Z","caller":"traceutil/trace.go:171","msg":"trace[1991358524] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"266.476355ms","start":"2026-03-17T21:57:26.051414Z","end":"2026-03-17T21:57:26.317891Z","steps":["trace[1991358524] 'process raft request' (duration: 266.26967ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:57:28.712189Z","caller":"traceutil/trace.go:171","msg":"trace[315420552] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"111.012667ms","start":"2026-03-17T21:57:28.601141Z","end":"2026-03-17T21:57:28.712153Z","steps":["trace[315420552] 'process raft request' (duration: 110.243848ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:57:29.117652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.361626ms","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-03-17T21:57:29.117724Z","caller":"traceutil/trace.go:171","msg":"trace[932948455] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:788; }","duration":"114.452018ms","start":"2026-03-17T21:57:29.003255Z","end":"2026-03-17T21:57:29.117707Z","steps":["trace[932948455] 'range keys from in-memory index tree' (duration: 114.347606ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:57:29.11805Z","caller":"traceutil/trace.go:171","msg":"trace[1954067074] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:818; }","duration":"114.002028ms","start":"2026-03-17T21:57:29.004019Z","end":"2026-03-17T21:57:29.118021Z","steps":["trace[1954067074] 'read index received' (duration: 93.950428ms)","trace[1954067074] 'applied index is now lower than readState.Index' (duration: 20.05047ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:57:29.118265Z","caller":"traceutil/trace.go:171","msg":"trace[1431882454] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"322.319701ms","start":"2026-03-17T21:57:28.795923Z","end":"2026-03-17T21:57:29.118243Z","steps":["trace[1431882454] 'process raft request' (duration: 302.141688ms)","trace[1431882454] 'compare' (duration: 19.438326ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:57:29.118272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.232483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.85\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-03-17T21:57:29.118319Z","caller":"traceutil/trace.go:171","msg":"trace[1283262531] range","detail":"{range_begin:/registry/masterleases/199.19.213.85; range_end:; response_count:1; response_revision:790; }","duration":"114.330926ms","start":"2026-03-17T21:57:29.003976Z","end":"2026-03-17T21:57:29.118307Z","steps":["trace[1283262531] 'agreement among raft nodes before linearized reading' (duration: 114.145711ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:57:29.118376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:57:28.7959Z","time spent":"322.408984ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T21:57:29.118393Z","caller":"traceutil/trace.go:171","msg":"trace[694178107] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"322.346652ms","start":"2026-03-17T21:57:28.795998Z","end":"2026-03-17T21:57:29.118345Z","steps":["trace[694178107] 'process raft request' (duration: 321.931172ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:57:29.118671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:57:28.795977Z","time spent":"322.574458ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T21:57:42.828045Z","caller":"traceutil/trace.go:171","msg":"trace[2084777120] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"326.395739ms","start":"2026-03-17T21:57:42.501626Z","end":"2026-03-17T21:57:42.828022Z","steps":["trace[2084777120] 'process raft request' (duration: 325.772064ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:57:42.828193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:57:42.501603Z","time spent":"326.511432ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T21:57:58.039997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.080136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-17T21:57:58.040137Z","caller":"traceutil/trace.go:171","msg":"trace[1607295058] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:935; }","duration":"195.280871ms","start":"2026-03-17T21:57:57.844837Z","end":"2026-03-17T21:57:58.040118Z","steps":["trace[1607295058] 'count revisions from in-memory index tree' (duration: 194.996254ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:00.18757Z","caller":"traceutil/trace.go:171","msg":"trace[913522601] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"151.353775ms","start":"2026-03-17T21:58:00.036191Z","end":"2026-03-17T21:58:00.187544Z","steps":["trace[913522601] 'process raft request' (duration: 151.14369ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:00.847249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.879967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T21:58:00.847311Z","caller":"traceutil/trace.go:171","msg":"trace[2102963519] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:954; }","duration":"410.987599ms","start":"2026-03-17T21:58:00.436308Z","end":"2026-03-17T21:58:00.847296Z","steps":["trace[2102963519] 'range keys from in-memory index tree' (duration: 410.805955ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:00.847338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:00.436288Z","time spent":"411.04352ms","remote":"127.0.0.1:42744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-17T21:58:01.273713Z","caller":"traceutil/trace.go:171","msg":"trace[382072057] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"154.081698ms","start":"2026-03-17T21:58:01.119602Z","end":"2026-03-17T21:58:01.273684Z","steps":["trace[382072057] 'process raft request' (duration: 63.106024ms)","trace[382072057] 'compare' (duration: 90.77866ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:58:01.273827Z","caller":"traceutil/trace.go:171","msg":"trace[1761581211] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"150.811052ms","start":"2026-03-17T21:58:01.122997Z","end":"2026-03-17T21:58:01.273808Z","steps":["trace[1761581211] 'process raft request' (duration: 150.590327ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:01.541572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.62308ms","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-03-17T21:58:01.54165Z","caller":"traceutil/trace.go:171","msg":"trace[577229687] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:957; }","duration":"118.749513ms","start":"2026-03-17T21:58:01.422884Z","end":"2026-03-17T21:58:01.541633Z","steps":["trace[577229687] 'range keys from in-memory index tree' (duration: 118.473487ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:01.579017Z","caller":"traceutil/trace.go:171","msg":"trace[1667381535] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"115.128079ms","start":"2026-03-17T21:58:01.463847Z","end":"2026-03-17T21:58:01.578975Z","steps":["trace[1667381535] 'process raft request' (duration: 114.912384ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:01.579074Z","caller":"traceutil/trace.go:171","msg":"trace[1031157335] linearizableReadLoop","detail":"{readStateIndex:997; appliedIndex:996; }","duration":"113.87977ms","start":"2026-03-17T21:58:01.465077Z","end":"2026-03-17T21:58:01.578957Z","steps":["trace[1031157335] 'read index received' (duration: 113.621994ms)","trace[1031157335] 'applied index is now lower than readState.Index' (duration: 256.226µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:58:01.579245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.153946ms","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-03-17T21:58:01.579339Z","caller":"traceutil/trace.go:171","msg":"trace[1163554037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:958; }","duration":"114.2861ms","start":"2026-03-17T21:58:01.46504Z","end":"2026-03-17T21:58:01.579326Z","steps":["trace[1163554037] 'agreement among raft nodes before linearized reading' (duration: 114.006463ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:02.142844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.947083ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T21:58:02.142946Z","caller":"traceutil/trace.go:171","msg":"trace[308285907] linearizableReadLoop","detail":"{readStateIndex:999; appliedIndex:997; }","duration":"547.051237ms","start":"2026-03-17T21:58:01.595878Z","end":"2026-03-17T21:58:02.142929Z","steps":["trace[308285907] 'read index received' (duration: 31.439914ms)","trace[308285907] 'applied index is now lower than readState.Index' (duration: 515.609943ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:58:02.143021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.141859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-17T21:58:02.143058Z","caller":"traceutil/trace.go:171","msg":"trace[74054775] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:960; }","duration":"547.20772ms","start":"2026-03-17T21:58:01.595842Z","end":"2026-03-17T21:58:02.14305Z","steps":["trace[74054775] 'agreement among raft nodes before linearized reading' (duration: 547.133518ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:02.143098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:01.595826Z","time spent":"547.262152ms","remote":"127.0.0.1:34228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":4,"response size":30,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"info","ts":"2026-03-17T21:58:02.14311Z","caller":"traceutil/trace.go:171","msg":"trace[63064374] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"559.692382ms","start":"2026-03-17T21:58:01.583386Z","end":"2026-03-17T21:58:02.143079Z","steps":["trace[63064374] 'process raft request' (duration: 78.279708ms)","trace[63064374] 'compare' (duration: 480.757268ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:58:02.14328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:01.583361Z","time spent":"559.832375ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T21:58:02.622416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.833271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T21:58:02.622509Z","caller":"traceutil/trace.go:171","msg":"trace[831246681] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:960; }","duration":"185.986454ms","start":"2026-03-17T21:58:02.436504Z","end":"2026-03-17T21:58:02.62249Z","steps":["trace[831246681] 'range keys from in-memory index tree' (duration: 185.758029ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:02.985555Z","caller":"traceutil/trace.go:171","msg":"trace[348014838] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"227.939663ms","start":"2026-03-17T21:58:02.757589Z","end":"2026-03-17T21:58:02.985529Z","steps":["trace[348014838] 'process raft request' (duration: 227.785989ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:03.175689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.77638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-03-17T21:58:03.175782Z","caller":"traceutil/trace.go:171","msg":"trace[380653912] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:961; }","duration":"114.934814ms","start":"2026-03-17T21:58:03.06082Z","end":"2026-03-17T21:58:03.175755Z","steps":["trace[380653912] 'range keys from in-memory index tree' (duration: 114.550965ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:03.846058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.533797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-03-17T21:58:03.846095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.887765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-03-17T21:58:03.846208Z","caller":"traceutil/trace.go:171","msg":"trace[1093690576] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:962; }","duration":"569.016678ms","start":"2026-03-17T21:58:03.277135Z","end":"2026-03-17T21:58:03.846152Z","steps":["trace[1093690576] 'range keys from in-memory index tree' (duration: 568.576599ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:03.84625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:03.277111Z","time spent":"569.129821ms","remote":"127.0.0.1:34338","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":"info","ts":"2026-03-17T21:58:03.846158Z","caller":"traceutil/trace.go:171","msg":"trace[2140487328] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:962; }","duration":"568.684801ms","start":"2026-03-17T21:58:03.27744Z","end":"2026-03-17T21:58:03.846124Z","steps":["trace[2140487328] 'range keys from in-memory index tree' (duration: 568.274212ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:03.846364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:03.277411Z","time spent":"568.938017ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-17T21:58:03.867504Z","caller":"traceutil/trace.go:171","msg":"trace[1194541327] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"499.139707ms","start":"2026-03-17T21:58:03.368348Z","end":"2026-03-17T21:58:03.867488Z","steps":["trace[1194541327] 'process raft request' (duration: 499.021724ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:03.867622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:03.368328Z","time spent":"499.232649ms","remote":"127.0.0.1:34244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5957,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T21:58:03.868121Z","caller":"traceutil/trace.go:171","msg":"trace[1578669872] linearizableReadLoop","detail":"{readStateIndex:1002; appliedIndex:1002; }","duration":"430.989475ms","start":"2026-03-17T21:58:03.43712Z","end":"2026-03-17T21:58:03.868109Z","steps":["trace[1578669872] 'read index received' (duration: 430.985605ms)","trace[1578669872] 'applied index is now lower than readState.Index' (duration: 3.14µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:58:03.868205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.089407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T21:58:03.868261Z","caller":"traceutil/trace.go:171","msg":"trace[1138663884] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:963; }","duration":"431.18734ms","start":"2026-03-17T21:58:03.437063Z","end":"2026-03-17T21:58:03.86825Z","steps":["trace[1138663884] 'agreement among raft nodes before linearized reading' (duration: 431.116048ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:03.868294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:03.437039Z","time spent":"431.247952ms","remote":"127.0.0.1:42744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-17T21:58:03.889767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.526818ms","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-03-17T21:58:03.889922Z","caller":"traceutil/trace.go:171","msg":"trace[1512535556] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:965; }","duration":"258.717352ms","start":"2026-03-17T21:58:03.631187Z","end":"2026-03-17T21:58:03.889904Z","steps":["trace[1512535556] 'agreement among raft nodes before linearized reading' (duration: 258.426825ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:03.89008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.247679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T21:58:03.890152Z","caller":"traceutil/trace.go:171","msg":"trace[1021490129] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:965; }","duration":"332.536576ms","start":"2026-03-17T21:58:03.557586Z","end":"2026-03-17T21:58:03.890123Z","steps":["trace[1021490129] 'agreement among raft nodes before linearized reading' (duration: 332.27012ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:03.890315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:03.557559Z","time spent":"332.711631ms","remote":"127.0.0.1:34312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-03-17T21:58:04.100402Z","caller":"traceutil/trace.go:171","msg":"trace[181636491] linearizableReadLoop","detail":"{readStateIndex:1006; appliedIndex:1005; }","duration":"126.267079ms","start":"2026-03-17T21:58:03.974109Z","end":"2026-03-17T21:58:04.100376Z","steps":["trace[181636491] 'read index received' (duration: 41.178312ms)","trace[181636491] 'applied index is now lower than readState.Index' (duration: 85.087737ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:58:04.100421Z","caller":"traceutil/trace.go:171","msg":"trace[358720436] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"196.669593ms","start":"2026-03-17T21:58:03.903717Z","end":"2026-03-17T21:58:04.100387Z","steps":["trace[358720436] 'process raft request' (duration: 111.568866ms)","trace[358720436] 'compare' (duration: 84.901842ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:58:04.10164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.427572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T21:58:04.101696Z","caller":"traceutil/trace.go:171","msg":"trace[349488830] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:967; }","duration":"127.61479ms","start":"2026-03-17T21:58:03.974064Z","end":"2026-03-17T21:58:04.101679Z","steps":["trace[349488830] 'agreement among raft nodes before linearized reading' (duration: 126.415122ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:04.658219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.521488ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-03-17T21:58:06.11412Z","caller":"traceutil/trace.go:171","msg":"trace[1222628752] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"217.255654ms","start":"2026-03-17T21:58:05.896839Z","end":"2026-03-17T21:58:06.114095Z","steps":["trace[1222628752] 'process raft request' (duration: 217.093521ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:06.125583Z","caller":"traceutil/trace.go:171","msg":"trace[1333930678] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"227.34228ms","start":"2026-03-17T21:58:05.898217Z","end":"2026-03-17T21:58:06.12556Z","steps":["trace[1333930678] 'process raft request' (duration: 227.107095ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:06.125552Z","caller":"traceutil/trace.go:171","msg":"trace[1075249936] linearizableReadLoop","detail":"{readStateIndex:1017; appliedIndex:1015; }","duration":"215.433741ms","start":"2026-03-17T21:58:05.910089Z","end":"2026-03-17T21:58:06.125523Z","steps":["trace[1075249936] 'read index received' (duration: 203.891612ms)","trace[1075249936] 'applied index is now lower than readState.Index' (duration: 11.540759ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:58:06.125958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.807271ms","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-03-17T21:58:06.126346Z","caller":"traceutil/trace.go:171","msg":"trace[1472925882] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:977; }","duration":"216.283851ms","start":"2026-03-17T21:58:05.910045Z","end":"2026-03-17T21:58:06.126329Z","steps":["trace[1472925882] 'agreement among raft nodes before linearized reading' (duration: 215.647486ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:10.361034Z","caller":"traceutil/trace.go:171","msg":"trace[986680277] linearizableReadLoop","detail":"{readStateIndex:1056; appliedIndex:1055; }","duration":"224.737169ms","start":"2026-03-17T21:58:10.136273Z","end":"2026-03-17T21:58:10.36101Z","steps":["trace[986680277] 'read index received' (duration: 224.711228ms)","trace[986680277] 'applied index is now lower than readState.Index' (duration: 24.891µs)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:58:10.361134Z","caller":"traceutil/trace.go:171","msg":"trace[1679276086] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"231.736113ms","start":"2026-03-17T21:58:10.129357Z","end":"2026-03-17T21:58:10.361093Z","steps":["trace[1679276086] 'process raft request' (duration: 231.493597ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:10.361295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.993155ms","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-03-17T21:58:10.361366Z","caller":"traceutil/trace.go:171","msg":"trace[551431812] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1015; }","duration":"225.104848ms","start":"2026-03-17T21:58:10.136245Z","end":"2026-03-17T21:58:10.36135Z","steps":["trace[551431812] 'agreement among raft nodes before linearized reading' (duration: 224.850502ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:10.429496Z","caller":"traceutil/trace.go:171","msg":"trace[1340370519] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"104.865949ms","start":"2026-03-17T21:58:10.324601Z","end":"2026-03-17T21:58:10.429467Z","steps":["trace[1340370519] 'process raft request' (duration: 104.674674ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:10.429536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.618501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-03-17T21:58:10.429601Z","caller":"traceutil/trace.go:171","msg":"trace[834977510] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1016; }","duration":"288.712084ms","start":"2026-03-17T21:58:10.140872Z","end":"2026-03-17T21:58:10.429584Z","steps":["trace[834977510] 'agreement among raft nodes before linearized reading' (duration: 288.514579ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:10.429692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.308739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-17T21:58:10.429727Z","caller":"traceutil/trace.go:171","msg":"trace[91986914] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1016; }","duration":"218.397131ms","start":"2026-03-17T21:58:10.211321Z","end":"2026-03-17T21:58:10.429718Z","steps":["trace[91986914] 'agreement among raft nodes before linearized reading' (duration: 218.235927ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:10.782617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.63076ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T21:58:10.782845Z","caller":"traceutil/trace.go:171","msg":"trace[1153179447] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"417.661594ms","start":"2026-03-17T21:58:10.36516Z","end":"2026-03-17T21:58:10.782821Z","steps":["trace[1153179447] 'process raft request' (duration: 292.743357ms)","trace[1153179447] 'compare' (duration: 124.485866ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:58:10.782941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:10.365134Z","time spent":"417.755196ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T21:58:10.783112Z","caller":"traceutil/trace.go:171","msg":"trace[2143967102] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"348.517069ms","start":"2026-03-17T21:58:10.434568Z","end":"2026-03-17T21:58:10.783085Z","steps":["trace[2143967102] 'process raft request' (duration: 348.1603ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:10.783206Z","caller":"traceutil/trace.go:171","msg":"trace[1845999366] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"348.555859ms","start":"2026-03-17T21:58:10.434642Z","end":"2026-03-17T21:58:10.783198Z","steps":["trace[1845999366] 'process raft request' (duration: 348.330684ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:10.783223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:10.434547Z","time spent":"348.627261ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T21:58:10.783246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:10.434635Z","time spent":"348.59131ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T21:58:10.783211Z","caller":"traceutil/trace.go:171","msg":"trace[382998705] linearizableReadLoop","detail":"{readStateIndex:1060; appliedIndex:1057; }","duration":"322.740597ms","start":"2026-03-17T21:58:10.460442Z","end":"2026-03-17T21:58:10.783182Z","steps":["trace[382998705] 'read index received' (duration: 197.522833ms)","trace[382998705] 'applied index is now lower than readState.Index' (duration: 125.215514ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:58:10.783444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.990642ms","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:532"} {"level":"info","ts":"2026-03-17T21:58:10.783506Z","caller":"traceutil/trace.go:171","msg":"trace[1312167832] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1019; }","duration":"323.101195ms","start":"2026-03-17T21:58:10.460389Z","end":"2026-03-17T21:58:10.78349Z","steps":["trace[1312167832] 'agreement among raft nodes before linearized reading' (duration: 322.89016ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:10.783558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:10.460374Z","time spent":"323.171766ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-03-17T21:58:12.865406Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":739888852665118430,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-17T21:58:13.335461Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.072332824s","expected-duration":"1s"} {"level":"info","ts":"2026-03-17T21:58:13.335868Z","caller":"traceutil/trace.go:171","msg":"trace[238714453] linearizableReadLoop","detail":"{readStateIndex:1063; appliedIndex:1062; }","duration":"971.230884ms","start":"2026-03-17T21:58:12.364609Z","end":"2026-03-17T21:58:13.33584Z","steps":["trace[238714453] 'read index received' (duration: 971.036979ms)","trace[238714453] 'applied index is now lower than readState.Index' (duration: 192.594µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:58:13.336028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"788.867374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T21:58:13.335998Z","caller":"traceutil/trace.go:171","msg":"trace[1371149260] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"1.200280293s","start":"2026-03-17T21:58:12.135687Z","end":"2026-03-17T21:58:13.335967Z","steps":["trace[1371149260] 'process raft request' (duration: 1.200005157s)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:13.336083Z","caller":"traceutil/trace.go:171","msg":"trace[1313623284] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1022; }","duration":"788.977477ms","start":"2026-03-17T21:58:12.547095Z","end":"2026-03-17T21:58:13.336072Z","steps":["trace[1313623284] 'agreement among raft nodes before linearized reading' (duration: 788.878485ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:13.336119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:12.547077Z","time spent":"789.034709ms","remote":"127.0.0.1:42744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-17T21:58:13.33616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"971.51837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-03-17T21:58:13.336233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:12.135659Z","time spent":"1.200435156s","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T21:58:13.336259Z","caller":"traceutil/trace.go:171","msg":"trace[1281766131] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1022; }","duration":"971.654883ms","start":"2026-03-17T21:58:12.36457Z","end":"2026-03-17T21:58:13.336224Z","steps":["trace[1281766131] 'agreement among raft nodes before linearized reading' (duration: 971.397317ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:13.336307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:12.364555Z","time spent":"971.741985ms","remote":"127.0.0.1:34338","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-03-17T21:58:13.336281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.311948ms","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:532"} {"level":"info","ts":"2026-03-17T21:58:13.336447Z","caller":"traceutil/trace.go:171","msg":"trace[1891854596] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1022; }","duration":"534.507643ms","start":"2026-03-17T21:58:12.801929Z","end":"2026-03-17T21:58:13.336436Z","steps":["trace[1891854596] 'agreement among raft nodes before linearized reading' (duration: 534.128195ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:13.336432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.422877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"warn","ts":"2026-03-17T21:58:13.33642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.360237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-03-17T21:58:13.336493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:12.801919Z","time spent":"534.565645ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-03-17T21:58:13.336497Z","caller":"traceutil/trace.go:171","msg":"trace[1937222777] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1022; }","duration":"339.51376ms","start":"2026-03-17T21:58:12.99697Z","end":"2026-03-17T21:58:13.336483Z","steps":["trace[1937222777] 'agreement among raft nodes before linearized reading' (duration: 339.367246ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:13.336498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.507841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-03-17T21:58:13.336548Z","caller":"traceutil/trace.go:171","msg":"trace[12537822] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1022; }","duration":"548.597103ms","start":"2026-03-17T21:58:12.78794Z","end":"2026-03-17T21:58:13.336537Z","steps":["trace[12537822] 'agreement among raft nodes before linearized reading' (duration: 548.438229ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:13.336534Z","caller":"traceutil/trace.go:171","msg":"trace[1548197382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1022; }","duration":"548.501421ms","start":"2026-03-17T21:58:12.787994Z","end":"2026-03-17T21:58:13.336496Z","steps":["trace[1548197382] 'agreement among raft nodes before linearized reading' (duration: 548.213234ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:13.336566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:12.996953Z","time spent":"339.602461ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-03-17T21:58:13.33659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:12.78792Z","time spent":"548.661284ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-17T21:58:13.336624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:12.787965Z","time spent":"548.626753ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-17T21:58:13.336741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.336836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-17T21:58:13.336775Z","caller":"traceutil/trace.go:171","msg":"trace[636435860] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1022; }","duration":"548.408638ms","start":"2026-03-17T21:58:12.788358Z","end":"2026-03-17T21:58:13.336767Z","steps":["trace[636435860] 'agreement among raft nodes before linearized reading' (duration: 548.320776ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:13.336801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:12.788339Z","time spent":"548.456589ms","remote":"127.0.0.1:34338","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-03-17T21:58:13.871812Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":739888852665118433,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-17T21:58:14.18294Z","caller":"traceutil/trace.go:171","msg":"trace[940827502] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"842.553168ms","start":"2026-03-17T21:58:13.340352Z","end":"2026-03-17T21:58:14.182905Z","steps":["trace[940827502] 'process raft request' (duration: 842.322552ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:14.183107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:13.340331Z","time spent":"842.697762ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T21:58:14.184215Z","caller":"traceutil/trace.go:171","msg":"trace[2127527905] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"842.266462ms","start":"2026-03-17T21:58:13.34192Z","end":"2026-03-17T21:58:14.184186Z","steps":["trace[2127527905] 'process raft request' (duration: 842.089358ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:14.184491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:13.341902Z","time spent":"842.432045ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T21:58:14.184519Z","caller":"traceutil/trace.go:171","msg":"trace[7636655] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"842.543849ms","start":"2026-03-17T21:58:13.341935Z","end":"2026-03-17T21:58:14.184479Z","steps":["trace[7636655] 'process raft request' (duration: 842.19368ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:14.184634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:13.341909Z","time spent":"842.672211ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T21:58:14.185438Z","caller":"traceutil/trace.go:171","msg":"trace[1940210544] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"843.377767ms","start":"2026-03-17T21:58:13.342033Z","end":"2026-03-17T21:58:14.185411Z","steps":["trace[1940210544] 'process raft request' (duration: 843.015929ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:14.185492Z","caller":"traceutil/trace.go:171","msg":"trace[1798154468] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"843.348227ms","start":"2026-03-17T21:58:13.342125Z","end":"2026-03-17T21:58:14.185473Z","steps":["trace[1798154468] 'process raft request' (duration: 843.160002ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:14.185496Z","caller":"traceutil/trace.go:171","msg":"trace[658323408] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"843.4892ms","start":"2026-03-17T21:58:13.341984Z","end":"2026-03-17T21:58:14.185473Z","steps":["trace[658323408] 'process raft request' (duration: 842.350293ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:14.185587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:13.342118Z","time spent":"843.418858ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T21:58:14.185609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:13.342025Z","time spent":"843.49418ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T21:58:14.185962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:13.341977Z","time spent":"843.700406ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T21:58:14.186145Z","caller":"traceutil/trace.go:171","msg":"trace[514040265] linearizableReadLoop","detail":"{readStateIndex:1069; appliedIndex:1064; }","duration":"814.888372ms","start":"2026-03-17T21:58:13.371237Z","end":"2026-03-17T21:58:14.186125Z","steps":["trace[514040265] 'read index received' (duration: 811.712518ms)","trace[514040265] 'applied index is now lower than readState.Index' (duration: 3.173804ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:58:14.18691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.820907ms","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-03-17T21:58:14.186985Z","caller":"traceutil/trace.go:171","msg":"trace[4350799] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1028; }","duration":"780.926019ms","start":"2026-03-17T21:58:13.406036Z","end":"2026-03-17T21:58:14.186962Z","steps":["trace[4350799] 'agreement among raft nodes before linearized reading' (duration: 780.696843ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:14.187032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:13.406015Z","time spent":"781.007881ms","remote":"127.0.0.1:34338","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-03-17T21:58:14.187045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.442158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-03-17T21:58:14.187055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.609014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T21:58:14.187102Z","caller":"traceutil/trace.go:171","msg":"trace[641731638] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1028; }","duration":"649.547331ms","start":"2026-03-17T21:58:13.537542Z","end":"2026-03-17T21:58:14.187089Z","steps":["trace[641731638] 'agreement among raft nodes before linearized reading' (duration: 649.449638ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:14.187144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:13.537519Z","time spent":"649.616012ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":12,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"info","ts":"2026-03-17T21:58:14.187106Z","caller":"traceutil/trace.go:171","msg":"trace[2020280122] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1028; }","duration":"748.681256ms","start":"2026-03-17T21:58:13.438412Z","end":"2026-03-17T21:58:14.187094Z","steps":["trace[2020280122] 'agreement among raft nodes before linearized reading' (duration: 748.611534ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:14.187437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:13.4384Z","time spent":"749.019023ms","remote":"127.0.0.1:42748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-17T21:58:14.187954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"816.715404ms","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:526"} {"level":"info","ts":"2026-03-17T21:58:14.188013Z","caller":"traceutil/trace.go:171","msg":"trace[1531605050] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1028; }","duration":"816.799907ms","start":"2026-03-17T21:58:13.371197Z","end":"2026-03-17T21:58:14.187997Z","steps":["trace[1531605050] 'agreement among raft nodes before linearized reading' (duration: 815.088957ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:14.188049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:13.371184Z","time spent":"816.854078ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-03-17T21:58:16.471053Z","caller":"traceutil/trace.go:171","msg":"trace[364880319] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"276.823575ms","start":"2026-03-17T21:58:16.194205Z","end":"2026-03-17T21:58:16.471029Z","steps":["trace[364880319] 'process raft request' (duration: 276.745943ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:16.471084Z","caller":"traceutil/trace.go:171","msg":"trace[546878137] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"276.913508ms","start":"2026-03-17T21:58:16.194142Z","end":"2026-03-17T21:58:16.471055Z","steps":["trace[546878137] 'process raft request' (duration: 253.311487ms)","trace[546878137] 'compare' (duration: 23.366175ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:58:16.471378Z","caller":"traceutil/trace.go:171","msg":"trace[1408751873] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"276.874536ms","start":"2026-03-17T21:58:16.194462Z","end":"2026-03-17T21:58:16.471337Z","steps":["trace[1408751873] 'process raft request' (duration: 276.529588ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:16.471445Z","caller":"traceutil/trace.go:171","msg":"trace[1509371772] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"275.512944ms","start":"2026-03-17T21:58:16.195872Z","end":"2026-03-17T21:58:16.471385Z","steps":["trace[1509371772] 'process raft request' (duration: 275.354331ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:16.471638Z","caller":"traceutil/trace.go:171","msg":"trace[2052342663] linearizableReadLoop","detail":"{readStateIndex:1079; appliedIndex:1074; }","duration":"271.88333ms","start":"2026-03-17T21:58:16.199427Z","end":"2026-03-17T21:58:16.47131Z","steps":["trace[2052342663] 'read index received' (duration: 57.333099ms)","trace[2052342663] 'applied index is now lower than readState.Index' (duration: 214.549171ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:58:16.471804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.35065ms","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-03-17T21:58:16.471842Z","caller":"traceutil/trace.go:171","msg":"trace[1315779589] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1037; }","duration":"272.420083ms","start":"2026-03-17T21:58:16.199412Z","end":"2026-03-17T21:58:16.471832Z","steps":["trace[1315779589] 'agreement among raft nodes before linearized reading' (duration: 272.276479ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:28.732011Z","caller":"traceutil/trace.go:171","msg":"trace[425442993] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"171.834242ms","start":"2026-03-17T21:58:28.559954Z","end":"2026-03-17T21:58:28.731788Z","steps":["trace[425442993] 'process raft request' (duration: 126.508493ms)","trace[425442993] 'compare' (duration: 44.94078ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:58:28.732203Z","caller":"traceutil/trace.go:171","msg":"trace[985034391] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"172.117069ms","start":"2026-03-17T21:58:28.560052Z","end":"2026-03-17T21:58:28.732169Z","steps":["trace[985034391] 'process raft request' (duration: 171.829422ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:28.732424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.651128ms","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-03-17T21:58:28.732504Z","caller":"traceutil/trace.go:171","msg":"trace[7999585] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1085; }","duration":"171.76117ms","start":"2026-03-17T21:58:28.560725Z","end":"2026-03-17T21:58:28.732486Z","steps":["trace[7999585] 'agreement among raft nodes before linearized reading' (duration: 171.557615ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:28.732663Z","caller":"traceutil/trace.go:171","msg":"trace[174720988] linearizableReadLoop","detail":"{readStateIndex:1129; appliedIndex:1126; }","duration":"171.346881ms","start":"2026-03-17T21:58:28.560747Z","end":"2026-03-17T21:58:28.732094Z","steps":["trace[174720988] 'read index received' (duration: 14.050657ms)","trace[174720988] 'applied index is now lower than readState.Index' (duration: 157.294784ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:58:28.949251Z","caller":"traceutil/trace.go:171","msg":"trace[606362991] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"212.235637ms","start":"2026-03-17T21:58:28.736974Z","end":"2026-03-17T21:58:28.94921Z","steps":["trace[606362991] 'process raft request' (duration: 144.887904ms)","trace[606362991] 'compare' (duration: 67.23454ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:58:46.868711Z","caller":"traceutil/trace.go:171","msg":"trace[1335717022] linearizableReadLoop","detail":"{readStateIndex:1206; appliedIndex:1205; }","duration":"145.491128ms","start":"2026-03-17T21:58:46.723193Z","end":"2026-03-17T21:58:46.868685Z","steps":["trace[1335717022] 'read index received' (duration: 145.391826ms)","trace[1335717022] 'applied index is now lower than readState.Index' (duration: 98.152µs)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:58:46.86881Z","caller":"traceutil/trace.go:171","msg":"trace[2071369741] transaction","detail":"{read_only:false; response_revision:1158; number_of_response:1; }","duration":"211.319975ms","start":"2026-03-17T21:58:46.657457Z","end":"2026-03-17T21:58:46.868777Z","steps":["trace[2071369741] 'process raft request' (duration: 211.056379ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:46.868961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.755044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-03-17T21:58:46.869015Z","caller":"traceutil/trace.go:171","msg":"trace[1636162074] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1158; }","duration":"145.854636ms","start":"2026-03-17T21:58:46.72314Z","end":"2026-03-17T21:58:46.868994Z","steps":["trace[1636162074] 'agreement among raft nodes before linearized reading' (duration: 145.685692ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:47.124048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.099072ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T21:58:47.124542Z","caller":"traceutil/trace.go:171","msg":"trace[525679313] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"251.616576ms","start":"2026-03-17T21:58:46.872873Z","end":"2026-03-17T21:58:47.124489Z","steps":["trace[525679313] 'process raft request' (duration: 251.293499ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:47.124672Z","caller":"traceutil/trace.go:171","msg":"trace[370326730] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"251.800491ms","start":"2026-03-17T21:58:46.872835Z","end":"2026-03-17T21:58:47.124635Z","steps":["trace[370326730] 'process raft request' (duration: 126.024974ms)","trace[370326730] 'compare' (duration: 124.936037ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:58:47.124636Z","caller":"traceutil/trace.go:171","msg":"trace[2053308778] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"249.826395ms","start":"2026-03-17T21:58:46.874713Z","end":"2026-03-17T21:58:47.124539Z","steps":["trace[2053308778] 'process raft request' (duration: 249.507827ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:52.620627Z","caller":"traceutil/trace.go:171","msg":"trace[1360968874] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"123.057404ms","start":"2026-03-17T21:58:52.497542Z","end":"2026-03-17T21:58:52.6206Z","steps":["trace[1360968874] 'process raft request' (duration: 122.848499ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:54.541441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.48944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T21:58:54.54155Z","caller":"traceutil/trace.go:171","msg":"trace[1420478139] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1190; }","duration":"104.675245ms","start":"2026-03-17T21:58:54.436844Z","end":"2026-03-17T21:58:54.54152Z","steps":["trace[1420478139] 'range keys from in-memory index tree' (duration: 104.393458ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:59.180081Z","caller":"traceutil/trace.go:171","msg":"trace[601231885] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"115.071538ms","start":"2026-03-17T21:58:59.064981Z","end":"2026-03-17T21:58:59.180052Z","steps":["trace[601231885] 'process raft request' (duration: 65.413598ms)","trace[601231885] 'compare' (duration: 49.526687ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:58:59.728546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.958ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T21:58:59.728851Z","caller":"traceutil/trace.go:171","msg":"trace[1434550261] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"390.571773ms","start":"2026-03-17T21:58:59.338245Z","end":"2026-03-17T21:58:59.728816Z","steps":["trace[1434550261] 'process raft request' (duration: 220.198614ms)","trace[1434550261] 'compare' (duration: 169.769905ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:58:59.728958Z","caller":"traceutil/trace.go:171","msg":"trace[1137564077] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"390.585294ms","start":"2026-03-17T21:58:59.338335Z","end":"2026-03-17T21:58:59.72892Z","steps":["trace[1137564077] 'process raft request' (duration: 390.361609ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:59.729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:59.338232Z","time spent":"390.689337ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T21:58:59.728999Z","caller":"traceutil/trace.go:171","msg":"trace[1475536457] linearizableReadLoop","detail":"{readStateIndex:1264; appliedIndex:1259; }","duration":"292.350609ms","start":"2026-03-17T21:58:59.436622Z","end":"2026-03-17T21:58:59.728973Z","steps":["trace[1475536457] 'read index received' (duration: 121.751664ms)","trace[1475536457] 'applied index is now lower than readState.Index' (duration: 170.597785ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:58:59.729102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:59.338309Z","time spent":"390.720157ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T21:58:59.729133Z","caller":"traceutil/trace.go:171","msg":"trace[1400681569] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"390.752167ms","start":"2026-03-17T21:58:59.338368Z","end":"2026-03-17T21:58:59.72912Z","steps":["trace[1400681569] 'process raft request' (duration: 390.44279ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:59.729211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:59.338357Z","time spent":"390.80935ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T21:58:59.72925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.637966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T21:58:59.729272Z","caller":"traceutil/trace.go:171","msg":"trace[179645071] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1213; }","duration":"292.701298ms","start":"2026-03-17T21:58:59.436564Z","end":"2026-03-17T21:58:59.729265Z","steps":["trace[179645071] 'agreement among raft nodes before linearized reading' (duration: 292.650437ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:58:59.729358Z","caller":"traceutil/trace.go:171","msg":"trace[1698054800] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"390.945102ms","start":"2026-03-17T21:58:59.338408Z","end":"2026-03-17T21:58:59.729353Z","steps":["trace[1698054800] 'process raft request' (duration: 390.45401ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:59.729392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:59.338384Z","time spent":"390.991423ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T21:58:59.729433Z","caller":"traceutil/trace.go:171","msg":"trace[566525129] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"390.601125ms","start":"2026-03-17T21:58:59.338827Z","end":"2026-03-17T21:58:59.729428Z","steps":["trace[566525129] 'process raft request' (duration: 390.091733ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:58:59.729453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:58:59.338816Z","time spent":"390.626185ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T21:58:59.729474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.813756ms","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-03-17T21:58:59.729521Z","caller":"traceutil/trace.go:171","msg":"trace[256245997] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1213; }","duration":"273.883748ms","start":"2026-03-17T21:58:59.455625Z","end":"2026-03-17T21:58:59.729509Z","steps":["trace[256245997] 'agreement among raft nodes before linearized reading' (duration: 273.756955ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:59:09.936041Z","caller":"traceutil/trace.go:171","msg":"trace[1732427635] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"189.076757ms","start":"2026-03-17T21:59:09.746934Z","end":"2026-03-17T21:59:09.936011Z","steps":["trace[1732427635] 'process raft request' (duration: 131.03189ms)","trace[1732427635] 'compare' (duration: 57.75855ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:59:09.961662Z","caller":"traceutil/trace.go:171","msg":"trace[1162564117] linearizableReadLoop","detail":"{readStateIndex:1305; appliedIndex:1303; }","duration":"188.500343ms","start":"2026-03-17T21:59:09.773143Z","end":"2026-03-17T21:59:09.961644Z","steps":["trace[1162564117] 'read index received' (duration: 104.928191ms)","trace[1162564117] 'applied index is now lower than readState.Index' (duration: 83.571172ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:59:09.961712Z","caller":"traceutil/trace.go:171","msg":"trace[1039382805] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"206.509404ms","start":"2026-03-17T21:59:09.755173Z","end":"2026-03-17T21:59:09.961683Z","steps":["trace[1039382805] 'process raft request' (duration: 206.3486ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:09.961882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.718988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-03-17T21:59:09.96189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.673207ms","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-03-17T21:59:09.961925Z","caller":"traceutil/trace.go:171","msg":"trace[1685455140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1252; }","duration":"188.79764ms","start":"2026-03-17T21:59:09.773118Z","end":"2026-03-17T21:59:09.961916Z","steps":["trace[1685455140] 'agreement among raft nodes before linearized reading' (duration: 188.634667ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:59:09.961938Z","caller":"traceutil/trace.go:171","msg":"trace[1249222252] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1252; }","duration":"188.739939ms","start":"2026-03-17T21:59:09.773186Z","end":"2026-03-17T21:59:09.961926Z","steps":["trace[1249222252] 'agreement among raft nodes before linearized reading' (duration: 188.606025ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:09.962103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.27114ms","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-03-17T21:59:09.962198Z","caller":"traceutil/trace.go:171","msg":"trace[653206103] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1252; }","duration":"156.403124ms","start":"2026-03-17T21:59:09.805781Z","end":"2026-03-17T21:59:09.962184Z","steps":["trace[653206103] 'agreement among raft nodes before linearized reading' (duration: 156.139747ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:59:18.500585Z","caller":"traceutil/trace.go:171","msg":"trace[1336095671] linearizableReadLoop","detail":"{readStateIndex:1336; appliedIndex:1335; }","duration":"472.156679ms","start":"2026-03-17T21:59:18.028407Z","end":"2026-03-17T21:59:18.500564Z","steps":["trace[1336095671] 'read index received' (duration: 471.872002ms)","trace[1336095671] 'applied index is now lower than readState.Index' (duration: 283.687µs)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:59:18.50067Z","caller":"traceutil/trace.go:171","msg":"trace[1729303453] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"989.360601ms","start":"2026-03-17T21:59:17.511278Z","end":"2026-03-17T21:59:18.500638Z","steps":["trace[1729303453] 'process raft request' (duration: 989.064864ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:18.500808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.072213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-03-17T21:59:18.500816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:59:17.511264Z","time spent":"989.473903ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T21:59:18.500869Z","caller":"traceutil/trace.go:171","msg":"trace[1197274890] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1282; }","duration":"444.183626ms","start":"2026-03-17T21:59:18.056672Z","end":"2026-03-17T21:59:18.500856Z","steps":["trace[1197274890] 'agreement among raft nodes before linearized reading' (duration: 444.024122ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:18.50086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.433926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-03-17T21:59:18.500908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:59:18.056654Z","time spent":"444.246648ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-17T21:59:18.500934Z","caller":"traceutil/trace.go:171","msg":"trace[887191788] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1282; }","duration":"472.563878ms","start":"2026-03-17T21:59:18.028352Z","end":"2026-03-17T21:59:18.500916Z","steps":["trace[887191788] 'agreement among raft nodes before linearized reading' (duration: 472.334913ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:18.500986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:59:18.028329Z","time spent":"472.64867ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-03-17T21:59:18.501046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.550438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-17T21:59:18.501143Z","caller":"traceutil/trace.go:171","msg":"trace[562400279] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1282; }","duration":"442.682641ms","start":"2026-03-17T21:59:18.058448Z","end":"2026-03-17T21:59:18.501131Z","steps":["trace[562400279] 'agreement among raft nodes before linearized reading' (duration: 442.491387ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:18.5012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:59:18.05842Z","time spent":"442.772202ms","remote":"127.0.0.1:34338","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-03-17T21:59:24.48232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.407152ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-03-17T21:59:24.739065Z","caller":"traceutil/trace.go:171","msg":"trace[89680661] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"117.74197ms","start":"2026-03-17T21:59:24.621281Z","end":"2026-03-17T21:59:24.739023Z","steps":["trace[89680661] 'process raft request' (duration: 106.527408ms)","trace[89680661] 'compare' (duration: 11.093539ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:59:25.032134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.94881ms","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-03-17T21:59:25.032207Z","caller":"traceutil/trace.go:171","msg":"trace[865242646] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1311; }","duration":"182.075693ms","start":"2026-03-17T21:59:24.850115Z","end":"2026-03-17T21:59:25.032191Z","steps":["trace[865242646] 'range keys from in-memory index tree' (duration: 181.687724ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:59:25.166026Z","caller":"traceutil/trace.go:171","msg":"trace[983206996] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"129.518196ms","start":"2026-03-17T21:59:25.036488Z","end":"2026-03-17T21:59:25.166006Z","steps":["trace[983206996] 'process raft request' (duration: 112.870007ms)","trace[983206996] 'compare' (duration: 16.530836ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:59:25.16623Z","caller":"traceutil/trace.go:171","msg":"trace[1701388606] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"129.528856ms","start":"2026-03-17T21:59:25.036676Z","end":"2026-03-17T21:59:25.166205Z","steps":["trace[1701388606] 'process raft request' (duration: 129.3038ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:59:26.958017Z","caller":"traceutil/trace.go:171","msg":"trace[654733358] linearizableReadLoop","detail":"{readStateIndex:1375; appliedIndex:1374; }","duration":"195.192669ms","start":"2026-03-17T21:59:26.762784Z","end":"2026-03-17T21:59:26.957977Z","steps":["trace[654733358] 'read index received' (duration: 7.209108ms)","trace[654733358] 'applied index is now lower than readState.Index' (duration: 187.982471ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:59:26.958045Z","caller":"traceutil/trace.go:171","msg":"trace[475598685] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"197.275288ms","start":"2026-03-17T21:59:26.760735Z","end":"2026-03-17T21:59:26.95801Z","steps":["trace[475598685] 'process raft request' (duration: 197.066763ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:26.958302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.493536ms","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-03-17T21:59:26.958349Z","caller":"traceutil/trace.go:171","msg":"trace[1195526328] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1319; }","duration":"195.587749ms","start":"2026-03-17T21:59:26.762748Z","end":"2026-03-17T21:59:26.958336Z","steps":["trace[1195526328] 'agreement among raft nodes before linearized reading' (duration: 195.349613ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:27.181355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.972892ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T21:59:27.181472Z","caller":"traceutil/trace.go:171","msg":"trace[1290806796] linearizableReadLoop","detail":"{readStateIndex:1376; appliedIndex:1375; }","duration":"106.259572ms","start":"2026-03-17T21:59:27.075196Z","end":"2026-03-17T21:59:27.181455Z","steps":["trace[1290806796] 'read index received' (duration: 54.131µs)","trace[1290806796] 'applied index is now lower than readState.Index' (duration: 106.203941ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:59:27.181589Z","caller":"traceutil/trace.go:171","msg":"trace[136166952] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"219.039426ms","start":"2026-03-17T21:59:26.962527Z","end":"2026-03-17T21:59:27.181566Z","steps":["trace[136166952] 'process raft request' (duration: 89.769017ms)","trace[136166952] 'compare' (duration: 128.824029ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:59:27.181699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.508408ms","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-03-17T21:59:27.182292Z","caller":"traceutil/trace.go:171","msg":"trace[1099284590] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1320; }","duration":"107.133752ms","start":"2026-03-17T21:59:27.075129Z","end":"2026-03-17T21:59:27.182263Z","steps":["trace[1099284590] 'agreement among raft nodes before linearized reading' (duration: 106.375525ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:27.437687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.861294ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T21:59:27.437992Z","caller":"traceutil/trace.go:171","msg":"trace[1443199882] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"192.009086ms","start":"2026-03-17T21:59:27.245946Z","end":"2026-03-17T21:59:27.437955Z","steps":["trace[1443199882] 'process raft request' (duration: 43.786893ms)","trace[1443199882] 'compare' (duration: 147.744991ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:59:29.077216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.751137ms","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-03-17T21:59:29.077282Z","caller":"traceutil/trace.go:171","msg":"trace[920392041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1325; }","duration":"113.85788ms","start":"2026-03-17T21:59:28.963408Z","end":"2026-03-17T21:59:29.077266Z","steps":["trace[920392041] 'range keys from in-memory index tree' (duration: 113.608714ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:59:29.582862Z","caller":"traceutil/trace.go:171","msg":"trace[1997578643] linearizableReadLoop","detail":"{readStateIndex:1386; appliedIndex:1385; }","duration":"146.003381ms","start":"2026-03-17T21:59:29.436829Z","end":"2026-03-17T21:59:29.582833Z","steps":["trace[1997578643] 'read index received' (duration: 127.820286ms)","trace[1997578643] 'applied index is now lower than readState.Index' (duration: 18.182035ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:59:29.58292Z","caller":"traceutil/trace.go:171","msg":"trace[1079525012] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"306.662033ms","start":"2026-03-17T21:59:29.276232Z","end":"2026-03-17T21:59:29.582894Z","steps":["trace[1079525012] 'process raft request' (duration: 288.478638ms)","trace[1079525012] 'compare' (duration: 17.899978ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:59:29.583036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.192305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T21:59:29.583404Z","caller":"traceutil/trace.go:171","msg":"trace[1970035680] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1329; }","duration":"146.591924ms","start":"2026-03-17T21:59:29.43678Z","end":"2026-03-17T21:59:29.583372Z","steps":["trace[1970035680] 'agreement among raft nodes before linearized reading' (duration: 146.197715ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:29.583348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:59:29.27621Z","time spent":"307.066142ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T21:59:29.583564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.956326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-03-17T21:59:29.584071Z","caller":"traceutil/trace.go:171","msg":"trace[322144540] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1329; }","duration":"142.535529ms","start":"2026-03-17T21:59:29.441521Z","end":"2026-03-17T21:59:29.584056Z","steps":["trace[322144540] 'agreement among raft nodes before linearized reading' (duration: 141.802772ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:59:43.067652Z","caller":"traceutil/trace.go:171","msg":"trace[2058589072] linearizableReadLoop","detail":"{readStateIndex:1442; appliedIndex:1441; }","duration":"197.966515ms","start":"2026-03-17T21:59:42.869661Z","end":"2026-03-17T21:59:43.067628Z","steps":["trace[2058589072] 'read index received' (duration: 197.76954ms)","trace[2058589072] 'applied index is now lower than readState.Index' (duration: 195.815µs)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:59:43.067821Z","caller":"traceutil/trace.go:171","msg":"trace[103932002] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"198.23981ms","start":"2026-03-17T21:59:42.869541Z","end":"2026-03-17T21:59:43.06778Z","steps":["trace[103932002] 'process raft request' (duration: 197.840291ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:43.067851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.150729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-17T21:59:43.067909Z","caller":"traceutil/trace.go:171","msg":"trace[1196121421] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1383; }","duration":"198.262041ms","start":"2026-03-17T21:59:42.869634Z","end":"2026-03-17T21:59:43.067896Z","steps":["trace[1196121421] 'agreement among raft nodes before linearized reading' (duration: 198.096357ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:59:45.437097Z","caller":"traceutil/trace.go:171","msg":"trace[1111214154] transaction","detail":"{read_only:false; response_revision:1393; number_of_response:1; }","duration":"186.074917ms","start":"2026-03-17T21:59:45.250995Z","end":"2026-03-17T21:59:45.43707Z","steps":["trace[1111214154] 'process raft request' (duration: 139.665092ms)","trace[1111214154] 'compare' (duration: 46.259841ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:59:45.649016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.208427ms","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-03-17T21:59:45.649098Z","caller":"traceutil/trace.go:171","msg":"trace[298674461] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1394; }","duration":"111.344421ms","start":"2026-03-17T21:59:45.537735Z","end":"2026-03-17T21:59:45.649079Z","steps":["trace[298674461] 'range keys from in-memory index tree' (duration: 111.025943ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:45.907987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.972457ms","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-03-17T21:59:45.908083Z","caller":"traceutil/trace.go:171","msg":"trace[2139093116] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1395; }","duration":"151.097989ms","start":"2026-03-17T21:59:45.756962Z","end":"2026-03-17T21:59:45.90806Z","steps":["trace[2139093116] 'range keys from in-memory index tree' (duration: 150.865834ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:59:46.024027Z","caller":"traceutil/trace.go:171","msg":"trace[1704964256] transaction","detail":"{read_only:false; response_revision:1396; number_of_response:1; }","duration":"112.12362ms","start":"2026-03-17T21:59:45.911872Z","end":"2026-03-17T21:59:46.023996Z","steps":["trace[1704964256] 'process raft request' (duration: 111.922365ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:59:46.024159Z","caller":"traceutil/trace.go:171","msg":"trace[940989914] transaction","detail":"{read_only:false; response_revision:1397; number_of_response:1; }","duration":"112.220882ms","start":"2026-03-17T21:59:45.911911Z","end":"2026-03-17T21:59:46.024132Z","steps":["trace[940989914] 'process raft request' (duration: 112.034767ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:46.683833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.098993ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T21:59:46.683942Z","caller":"traceutil/trace.go:171","msg":"trace[1659367596] transaction","detail":"{read_only:false; response_revision:1398; number_of_response:1; }","duration":"380.605911ms","start":"2026-03-17T21:59:46.303317Z","end":"2026-03-17T21:59:46.683923Z","steps":["trace[1659367596] 'process raft request' (duration: 210.339173ms)","trace[1659367596] 'compare' (duration: 169.968661ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:59:46.68423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:59:46.30329Z","time spent":"380.683002ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T21:59:47.062619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.18848ms","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:532"} {"level":"info","ts":"2026-03-17T21:59:47.062721Z","caller":"traceutil/trace.go:171","msg":"trace[851720284] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1398; }","duration":"240.323383ms","start":"2026-03-17T21:59:46.822368Z","end":"2026-03-17T21:59:47.062692Z","steps":["trace[851720284] 'range keys from in-memory index tree' (duration: 239.969836ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:59:47.630281Z","caller":"traceutil/trace.go:171","msg":"trace[655591425] linearizableReadLoop","detail":"{readStateIndex:1460; appliedIndex:1459; }","duration":"248.986926ms","start":"2026-03-17T21:59:47.381258Z","end":"2026-03-17T21:59:47.630245Z","steps":["trace[655591425] 'read index received' (duration: 248.764281ms)","trace[655591425] 'applied index is now lower than readState.Index' (duration: 221.635µs)"],"step_count":2} {"level":"info","ts":"2026-03-17T21:59:47.630403Z","caller":"traceutil/trace.go:171","msg":"trace[540704789] transaction","detail":"{read_only:false; response_revision:1400; number_of_response:1; }","duration":"495.945234ms","start":"2026-03-17T21:59:47.134444Z","end":"2026-03-17T21:59:47.630389Z","steps":["trace[540704789] 'process raft request' (duration: 495.642287ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:47.6305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.271745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T21:59:47.630573Z","caller":"traceutil/trace.go:171","msg":"trace[1598329080] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1400; }","duration":"193.391327ms","start":"2026-03-17T21:59:47.437163Z","end":"2026-03-17T21:59:47.630554Z","steps":["trace[1598329080] 'agreement among raft nodes before linearized reading' (duration: 193.275675ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:47.630604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.342225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-17T21:59:47.630658Z","caller":"traceutil/trace.go:171","msg":"trace[916357378] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1400; }","duration":"249.415446ms","start":"2026-03-17T21:59:47.381228Z","end":"2026-03-17T21:59:47.630643Z","steps":["trace[916357378] 'agreement among raft nodes before linearized reading' (duration: 249.335125ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:47.630855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.047895ms","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-03-17T21:59:47.630896Z","caller":"traceutil/trace.go:171","msg":"trace[60595875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1400; }","duration":"129.108266ms","start":"2026-03-17T21:59:47.501778Z","end":"2026-03-17T21:59:47.630886Z","steps":["trace[60595875] 'agreement among raft nodes before linearized reading' (duration: 128.994173ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:47.630518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T21:59:47.13442Z","time spent":"496.015196ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T21:59:47.789116Z","caller":"traceutil/trace.go:171","msg":"trace[880822414] transaction","detail":"{read_only:false; response_revision:1401; number_of_response:1; }","duration":"153.483096ms","start":"2026-03-17T21:59:47.63561Z","end":"2026-03-17T21:59:47.789093Z","steps":["trace[880822414] 'process raft request' (duration: 104.394029ms)","trace[880822414] 'compare' (duration: 48.747649ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:59:48.134508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.993256ms","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-03-17T21:59:48.134587Z","caller":"traceutil/trace.go:171","msg":"trace[1724072685] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1402; }","duration":"106.127949ms","start":"2026-03-17T21:59:48.028441Z","end":"2026-03-17T21:59:48.134569Z","steps":["trace[1724072685] 'range keys from in-memory index tree' (duration: 105.819142ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:48.13485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.682842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-03-17T21:59:48.134922Z","caller":"traceutil/trace.go:171","msg":"trace[841886346] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1402; }","duration":"106.796245ms","start":"2026-03-17T21:59:48.028105Z","end":"2026-03-17T21:59:48.134902Z","steps":["trace[841886346] 'range keys from in-memory index tree' (duration: 106.503918ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T21:59:48.884566Z","caller":"traceutil/trace.go:171","msg":"trace[1748089495] transaction","detail":"{read_only:false; response_revision:1405; number_of_response:1; }","duration":"155.531813ms","start":"2026-03-17T21:59:48.729015Z","end":"2026-03-17T21:59:48.884547Z","steps":["trace[1748089495] 'process raft request' (duration: 155.4141ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:52.426461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.10257ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T21:59:52.426559Z","caller":"traceutil/trace.go:171","msg":"trace[324259962] transaction","detail":"{read_only:false; response_revision:1422; number_of_response:1; }","duration":"198.68271ms","start":"2026-03-17T21:59:52.227861Z","end":"2026-03-17T21:59:52.426544Z","steps":["trace[324259962] 'process raft request' (duration: 32.411436ms)","trace[324259962] 'compare' (duration: 165.983318ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T21:59:54.076272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.755413ms","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:534"} {"level":"info","ts":"2026-03-17T21:59:54.076358Z","caller":"traceutil/trace.go:171","msg":"trace[1279733496] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1424; }","duration":"186.895826ms","start":"2026-03-17T21:59:53.889438Z","end":"2026-03-17T21:59:54.076333Z","steps":["trace[1279733496] 'range keys from in-memory index tree' (duration: 186.550527ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:54.076355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.29604ms","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-03-17T21:59:54.076466Z","caller":"traceutil/trace.go:171","msg":"trace[1561240374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1424; }","duration":"224.423493ms","start":"2026-03-17T21:59:53.852025Z","end":"2026-03-17T21:59:54.076449Z","steps":["trace[1561240374] 'range keys from in-memory index tree' (duration: 224.096074ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:54.076621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.757827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T21:59:54.076663Z","caller":"traceutil/trace.go:171","msg":"trace[1059153405] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1424; }","duration":"128.846979ms","start":"2026-03-17T21:59:53.947806Z","end":"2026-03-17T21:59:54.076653Z","steps":["trace[1059153405] 'count revisions from in-memory index tree' (duration: 128.677375ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T21:59:54.076859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.591103ms","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-03-17T21:59:54.076892Z","caller":"traceutil/trace.go:171","msg":"trace[640222730] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1424; }","duration":"104.650565ms","start":"2026-03-17T21:59:53.972234Z","end":"2026-03-17T21:59:54.076884Z","steps":["trace[640222730] 'range keys from in-memory index tree' (duration: 104.494261ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:00:02.666087Z","caller":"traceutil/trace.go:171","msg":"trace[1892057511] transaction","detail":"{read_only:false; response_revision:1463; number_of_response:1; }","duration":"164.770111ms","start":"2026-03-17T22:00:02.50128Z","end":"2026-03-17T22:00:02.66605Z","steps":["trace[1892057511] 'process raft request' (duration: 103.129637ms)","trace[1892057511] 'compare' (duration: 61.493581ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T22:00:04.250179Z","caller":"traceutil/trace.go:171","msg":"trace[1137862764] transaction","detail":"{read_only:false; response_revision:1466; number_of_response:1; }","duration":"124.353384ms","start":"2026-03-17T22:00:04.125768Z","end":"2026-03-17T22:00:04.250122Z","steps":["trace[1137862764] 'process raft request' (duration: 124.093468ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:00:04.807111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.408021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-17T22:00:04.80721Z","caller":"traceutil/trace.go:171","msg":"trace[1436856455] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1468; }","duration":"484.558664ms","start":"2026-03-17T22:00:04.322632Z","end":"2026-03-17T22:00:04.80719Z","steps":["trace[1436856455] 'count revisions from in-memory index tree' (duration: 484.322639ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:00:04.807255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:00:04.322614Z","time spent":"484.630206ms","remote":"127.0.0.1:34574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-03-17T22:00:05.012736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.596646ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-03-17T22:00:05.012856Z","caller":"traceutil/trace.go:171","msg":"trace[643237525] linearizableReadLoop","detail":"{readStateIndex:1532; appliedIndex:1531; }","duration":"611.55975ms","start":"2026-03-17T22:00:04.401275Z","end":"2026-03-17T22:00:05.012834Z","steps":["trace[643237525] 'read index received' (duration: 18.889872ms)","trace[643237525] 'applied index is now lower than readState.Index' (duration: 592.668088ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:00:05.013106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.770792ms","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-03-17T22:00:05.013116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.817535ms","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-03-17T22:00:05.013148Z","caller":"traceutil/trace.go:171","msg":"trace[1213342361] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1468; }","duration":"342.857804ms","start":"2026-03-17T22:00:04.670278Z","end":"2026-03-17T22:00:05.013135Z","steps":["trace[1213342361] 'agreement among raft nodes before linearized reading' (duration: 342.69009ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:00:05.013191Z","caller":"traceutil/trace.go:171","msg":"trace[1488017197] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1468; }","duration":"611.938999ms","start":"2026-03-17T22:00:04.40123Z","end":"2026-03-17T22:00:05.013169Z","steps":["trace[1488017197] 'agreement among raft nodes before linearized reading' (duration: 611.687183ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:00:05.013198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:00:04.670258Z","time spent":"342.931295ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-17T22:00:05.013245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:00:04.401211Z","time spent":"612.025301ms","remote":"127.0.0.1:34338","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":"info","ts":"2026-03-17T22:00:05.139362Z","caller":"traceutil/trace.go:171","msg":"trace[487153003] transaction","detail":"{read_only:false; response_revision:1469; number_of_response:1; }","duration":"121.468306ms","start":"2026-03-17T22:00:05.017874Z","end":"2026-03-17T22:00:05.139342Z","steps":["trace[487153003] 'process raft request' (duration: 121.336413ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:00:05.186494Z","caller":"traceutil/trace.go:171","msg":"trace[2080391564] linearizableReadLoop","detail":"{readStateIndex:1534; appliedIndex:1532; }","duration":"136.5433ms","start":"2026-03-17T22:00:05.049929Z","end":"2026-03-17T22:00:05.186472Z","steps":["trace[2080391564] 'read index received' (duration: 89.355324ms)","trace[2080391564] 'applied index is now lower than readState.Index' (duration: 47.186826ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T22:00:05.186551Z","caller":"traceutil/trace.go:171","msg":"trace[63108649] transaction","detail":"{read_only:false; response_revision:1470; number_of_response:1; }","duration":"168.228922ms","start":"2026-03-17T22:00:05.018289Z","end":"2026-03-17T22:00:05.186518Z","steps":["trace[63108649] 'process raft request' (duration: 168.036677ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:00:05.186718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.754635ms","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:508"} {"level":"info","ts":"2026-03-17T22:00:05.186765Z","caller":"traceutil/trace.go:171","msg":"trace[564543510] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1470; }","duration":"136.860087ms","start":"2026-03-17T22:00:05.04989Z","end":"2026-03-17T22:00:05.18675Z","steps":["trace[564543510] 'agreement among raft nodes before linearized reading' (duration: 136.671123ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:00:05.360118Z","caller":"traceutil/trace.go:171","msg":"trace[622489962] transaction","detail":"{read_only:false; response_revision:1471; number_of_response:1; }","duration":"169.279546ms","start":"2026-03-17T22:00:05.190817Z","end":"2026-03-17T22:00:05.360097Z","steps":["trace[622489962] 'process raft request' (duration: 101.041367ms)","trace[622489962] 'compare' (duration: 68.068355ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T22:00:14.052561Z","caller":"traceutil/trace.go:171","msg":"trace[180082822] transaction","detail":"{read_only:false; response_revision:1506; number_of_response:1; }","duration":"102.565443ms","start":"2026-03-17T22:00:13.949971Z","end":"2026-03-17T22:00:14.052537Z","steps":["trace[180082822] 'process raft request' (duration: 102.4303ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:00:14.244137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.763009ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-03-17T22:00:14.24429Z","caller":"traceutil/trace.go:171","msg":"trace[1688600461] linearizableReadLoop","detail":"{readStateIndex:1572; appliedIndex:1571; }","duration":"195.126462ms","start":"2026-03-17T22:00:14.049146Z","end":"2026-03-17T22:00:14.244273Z","steps":["trace[1688600461] 'read index received' (duration: 3.488392ms)","trace[1688600461] 'applied index is now lower than readState.Index' (duration: 191.63641ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:00:14.244386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.219404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T22:00:14.244423Z","caller":"traceutil/trace.go:171","msg":"trace[762475517] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1506; }","duration":"195.313916ms","start":"2026-03-17T22:00:14.049098Z","end":"2026-03-17T22:00:14.244412Z","steps":["trace[762475517] 'agreement among raft nodes before linearized reading' (duration: 195.229034ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:00:18.614763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.061829ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T22:00:18.614878Z","caller":"traceutil/trace.go:171","msg":"trace[1707769355] transaction","detail":"{read_only:false; response_revision:1525; number_of_response:1; }","duration":"226.410545ms","start":"2026-03-17T22:00:18.388446Z","end":"2026-03-17T22:00:18.614857Z","steps":["trace[1707769355] 'process raft request' (duration: 84.151852ms)","trace[1707769355] 'compare' (duration: 141.937366ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:00:19.279657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.273832ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T22:00:19.279733Z","caller":"traceutil/trace.go:171","msg":"trace[443806058] transaction","detail":"{read_only:false; response_revision:1526; number_of_response:1; }","duration":"234.434433ms","start":"2026-03-17T22:00:19.045287Z","end":"2026-03-17T22:00:19.279722Z","steps":["trace[443806058] 'process raft request' (duration: 75.041618ms)","trace[443806058] 'compare' (duration: 159.17743ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T22:00:19.592059Z","caller":"traceutil/trace.go:171","msg":"trace[812552767] linearizableReadLoop","detail":"{readStateIndex:1594; appliedIndex:1593; }","duration":"279.727224ms","start":"2026-03-17T22:00:19.312315Z","end":"2026-03-17T22:00:19.592042Z","steps":["trace[812552767] 'read index received' (duration: 236.192574ms)","trace[812552767] 'applied index is now lower than readState.Index' (duration: 43.53409ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T22:00:19.59225Z","caller":"traceutil/trace.go:171","msg":"trace[2051828258] transaction","detail":"{read_only:false; response_revision:1527; number_of_response:1; }","duration":"297.481119ms","start":"2026-03-17T22:00:19.294762Z","end":"2026-03-17T22:00:19.592244Z","steps":["trace[2051828258] 'process raft request' (duration: 253.764265ms)","trace[2051828258] 'compare' (duration: 43.433138ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:00:19.592424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.102902ms","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-03-17T22:00:19.592449Z","caller":"traceutil/trace.go:171","msg":"trace[177256621] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1527; }","duration":"280.196014ms","start":"2026-03-17T22:00:19.312247Z","end":"2026-03-17T22:00:19.592443Z","steps":["trace[177256621] 'agreement among raft nodes before linearized reading' (duration: 280.104332ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:00:19.592556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.69255ms","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-03-17T22:00:19.592609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.622902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T22:00:19.592637Z","caller":"traceutil/trace.go:171","msg":"trace[1114641933] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1527; }","duration":"182.813363ms","start":"2026-03-17T22:00:19.409801Z","end":"2026-03-17T22:00:19.592615Z","steps":["trace[1114641933] 'agreement among raft nodes before linearized reading' (duration: 182.616598ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:00:19.592678Z","caller":"traceutil/trace.go:171","msg":"trace[1329410343] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1527; }","duration":"154.731644ms","start":"2026-03-17T22:00:19.437931Z","end":"2026-03-17T22:00:19.592662Z","steps":["trace[1329410343] 'agreement among raft nodes before linearized reading' (duration: 154.635522ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:00:19.97856Z","caller":"traceutil/trace.go:171","msg":"trace[1151107312] transaction","detail":"{read_only:false; response_revision:1530; number_of_response:1; }","duration":"381.834427ms","start":"2026-03-17T22:00:19.596702Z","end":"2026-03-17T22:00:19.978536Z","steps":["trace[1151107312] 'process raft request' (duration: 381.774375ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:00:19.978574Z","caller":"traceutil/trace.go:171","msg":"trace[1584170314] transaction","detail":"{read_only:false; response_revision:1528; number_of_response:1; }","duration":"382.192155ms","start":"2026-03-17T22:00:19.596306Z","end":"2026-03-17T22:00:19.978499Z","steps":["trace[1584170314] 'process raft request' (duration: 302.384795ms)","trace[1584170314] 'compare' (duration: 79.343729ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:00:19.978714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:00:19.596675Z","time spent":"381.9559ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T22:00:19.97876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:00:19.596286Z","time spent":"382.37896ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T22:00:19.97973Z","caller":"traceutil/trace.go:171","msg":"trace[1592951410] transaction","detail":"{read_only:false; response_revision:1529; number_of_response:1; }","duration":"382.306769ms","start":"2026-03-17T22:00:19.59656Z","end":"2026-03-17T22:00:19.978866Z","steps":["trace[1592951410] 'process raft request' (duration: 381.844038ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:00:19.979958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:00:19.596547Z","time spent":"383.318682ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T22:00:20.188218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.787195ms","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-03-17T22:00:20.188329Z","caller":"traceutil/trace.go:171","msg":"trace[744935168] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1530; }","duration":"101.9847ms","start":"2026-03-17T22:00:20.086316Z","end":"2026-03-17T22:00:20.1883Z","steps":["trace[744935168] 'range keys from in-memory index tree' (duration: 101.538229ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:00:22.118268Z","caller":"traceutil/trace.go:171","msg":"trace[2121431341] transaction","detail":"{read_only:false; response_revision:1538; number_of_response:1; }","duration":"130.869667ms","start":"2026-03-17T22:00:21.987377Z","end":"2026-03-17T22:00:22.118247Z","steps":["trace[2121431341] 'process raft request' (duration: 130.535869ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:00:22.118223Z","caller":"traceutil/trace.go:171","msg":"trace[1994928003] transaction","detail":"{read_only:false; response_revision:1539; number_of_response:1; }","duration":"130.020556ms","start":"2026-03-17T22:00:21.988135Z","end":"2026-03-17T22:00:22.118156Z","steps":["trace[1994928003] 'process raft request' (duration: 129.957575ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:00:23.380936Z","caller":"traceutil/trace.go:171","msg":"trace[919789794] transaction","detail":"{read_only:false; response_revision:1543; number_of_response:1; }","duration":"241.808086ms","start":"2026-03-17T22:00:23.139105Z","end":"2026-03-17T22:00:23.380913Z","steps":["trace[919789794] 'process raft request' (duration: 241.662353ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:00:36.225682Z","caller":"traceutil/trace.go:171","msg":"trace[381243502] transaction","detail":"{read_only:false; response_revision:1595; number_of_response:1; }","duration":"114.538414ms","start":"2026-03-17T22:00:36.111121Z","end":"2026-03-17T22:00:36.225659Z","steps":["trace[381243502] 'process raft request' (duration: 114.252977ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:00:40.450807Z","caller":"traceutil/trace.go:171","msg":"trace[704625202] linearizableReadLoop","detail":"{readStateIndex:1683; appliedIndex:1681; }","duration":"105.801589ms","start":"2026-03-17T22:00:40.344984Z","end":"2026-03-17T22:00:40.450786Z","steps":["trace[704625202] 'read index received' (duration: 17.114501ms)","trace[704625202] 'applied index is now lower than readState.Index' (duration: 88.686058ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T22:00:40.451336Z","caller":"traceutil/trace.go:171","msg":"trace[1573587141] transaction","detail":"{read_only:false; response_revision:1612; number_of_response:1; }","duration":"178.575245ms","start":"2026-03-17T22:00:40.272742Z","end":"2026-03-17T22:00:40.451317Z","steps":["trace[1573587141] 'process raft request' (duration: 105.991034ms)","trace[1573587141] 'compare' (duration: 71.937606ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:00:40.451771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.775662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-03-17T22:00:40.451819Z","caller":"traceutil/trace.go:171","msg":"trace[632032935] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1612; }","duration":"106.876144ms","start":"2026-03-17T22:00:40.344931Z","end":"2026-03-17T22:00:40.451807Z","steps":["trace[632032935] 'agreement among raft nodes before linearized reading' (duration: 106.731921ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:00:40.592744Z","caller":"traceutil/trace.go:171","msg":"trace[262191845] transaction","detail":"{read_only:false; response_revision:1613; number_of_response:1; }","duration":"136.008417ms","start":"2026-03-17T22:00:40.456681Z","end":"2026-03-17T22:00:40.59269Z","steps":["trace[262191845] 'process raft request' (duration: 97.642878ms)","trace[262191845] 'compare' (duration: 38.174644ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:01:19.085405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.669558ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T22:01:19.085571Z","caller":"traceutil/trace.go:171","msg":"trace[1446150987] linearizableReadLoop","detail":"{readStateIndex:1868; appliedIndex:1866; }","duration":"355.054797ms","start":"2026-03-17T22:01:18.730499Z","end":"2026-03-17T22:01:19.085554Z","steps":["trace[1446150987] 'read index received' (duration: 67.233685ms)","trace[1446150987] 'applied index is now lower than readState.Index' (duration: 287.820362ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T22:01:19.085623Z","caller":"traceutil/trace.go:171","msg":"trace[705483938] transaction","detail":"{read_only:false; response_revision:1789; number_of_response:1; }","duration":"355.658861ms","start":"2026-03-17T22:01:18.72994Z","end":"2026-03-17T22:01:19.085599Z","steps":["trace[705483938] 'process raft request' (duration: 355.563999ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:19.085773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:18.729924Z","time spent":"355.752763ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T22:01:19.085872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.923317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-03-17T22:01:19.085946Z","caller":"traceutil/trace.go:171","msg":"trace[1971270295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1789; }","duration":"274.04583ms","start":"2026-03-17T22:01:18.811884Z","end":"2026-03-17T22:01:19.08593Z","steps":["trace[1971270295] 'agreement among raft nodes before linearized reading' (duration: 273.824904ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:19.086021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.024767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-03-17T22:01:19.086146Z","caller":"traceutil/trace.go:171","msg":"trace[2088826478] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1789; }","duration":"227.203172ms","start":"2026-03-17T22:01:18.85891Z","end":"2026-03-17T22:01:19.086113Z","steps":["trace[2088826478] 'agreement among raft nodes before linearized reading' (duration: 226.883424ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:19.086764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.465686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/csi-d866efc76724112fcde143ccba2b796ce528d1c8f8862d387f2abccf1e36a50b\" ","response":"range_response_count:1 size:651"} {"level":"info","ts":"2026-03-17T22:01:19.086847Z","caller":"traceutil/trace.go:171","msg":"trace[223869601] range","detail":"{range_begin:/registry/volumeattachments/csi-d866efc76724112fcde143ccba2b796ce528d1c8f8862d387f2abccf1e36a50b; range_end:; response_count:1; response_revision:1789; }","duration":"356.353597ms","start":"2026-03-17T22:01:18.73047Z","end":"2026-03-17T22:01:19.086824Z","steps":["trace[223869601] 'agreement among raft nodes before linearized reading' (duration: 355.17025ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:19.08692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:18.730457Z","time spent":"356.439249ms","remote":"127.0.0.1:34474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":1,"response size":674,"request content":"key:\"/registry/volumeattachments/csi-d866efc76724112fcde143ccba2b796ce528d1c8f8862d387f2abccf1e36a50b\" "} {"level":"warn","ts":"2026-03-17T22:01:19.087247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.398324ms","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-03-17T22:01:19.087425Z","caller":"traceutil/trace.go:171","msg":"trace[1890249407] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1789; }","duration":"124.616299ms","start":"2026-03-17T22:01:18.962794Z","end":"2026-03-17T22:01:19.087411Z","steps":["trace[1890249407] 'agreement among raft nodes before linearized reading' (duration: 122.967801ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:19.085949Z","caller":"traceutil/trace.go:171","msg":"trace[831857828] transaction","detail":"{read_only:false; response_revision:1788; number_of_response:1; }","duration":"356.921551ms","start":"2026-03-17T22:01:18.728759Z","end":"2026-03-17T22:01:19.085681Z","steps":["trace[831857828] 'process raft request' (duration: 68.874054ms)","trace[831857828] 'compare' (duration: 287.523974ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:01:19.087722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:18.728737Z","time spent":"358.939328ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T22:01:19.311752Z","caller":"traceutil/trace.go:171","msg":"trace[1092124967] transaction","detail":"{read_only:false; response_revision:1793; number_of_response:1; }","duration":"190.484482ms","start":"2026-03-17T22:01:19.121235Z","end":"2026-03-17T22:01:19.311719Z","steps":["trace[1092124967] 'process raft request' (duration: 190.451381ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:19.311984Z","caller":"traceutil/trace.go:171","msg":"trace[170342377] transaction","detail":"{read_only:false; response_revision:1790; number_of_response:1; }","duration":"222.277707ms","start":"2026-03-17T22:01:19.089695Z","end":"2026-03-17T22:01:19.311973Z","steps":["trace[170342377] 'process raft request' (duration: 213.035171ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:19.312099Z","caller":"traceutil/trace.go:171","msg":"trace[739940816] linearizableReadLoop","detail":"{readStateIndex:1872; appliedIndex:1868; }","duration":"219.109693ms","start":"2026-03-17T22:01:19.092983Z","end":"2026-03-17T22:01:19.312093Z","steps":["trace[739940816] 'read index received' (duration: 27.30244ms)","trace[739940816] 'applied index is now lower than readState.Index' (duration: 191.806663ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T22:01:19.311875Z","caller":"traceutil/trace.go:171","msg":"trace[750207792] transaction","detail":"{read_only:false; response_revision:1791; number_of_response:1; }","duration":"220.134297ms","start":"2026-03-17T22:01:19.091712Z","end":"2026-03-17T22:01:19.311846Z","steps":["trace[750207792] 'process raft request' (duration: 219.906102ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:19.312197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.196625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/csi-d866efc76724112fcde143ccba2b796ce528d1c8f8862d387f2abccf1e36a50b\" ","response":"range_response_count:1 size:651"} {"level":"info","ts":"2026-03-17T22:01:19.31222Z","caller":"traceutil/trace.go:171","msg":"trace[1826723206] range","detail":"{range_begin:/registry/volumeattachments/csi-d866efc76724112fcde143ccba2b796ce528d1c8f8862d387f2abccf1e36a50b; range_end:; response_count:1; response_revision:1793; }","duration":"219.244097ms","start":"2026-03-17T22:01:19.092968Z","end":"2026-03-17T22:01:19.312212Z","steps":["trace[1826723206] 'agreement among raft nodes before linearized reading' (duration: 219.145554ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:19.312444Z","caller":"traceutil/trace.go:171","msg":"trace[1201933819] transaction","detail":"{read_only:false; response_revision:1792; number_of_response:1; }","duration":"220.661989ms","start":"2026-03-17T22:01:19.09175Z","end":"2026-03-17T22:01:19.312412Z","steps":["trace[1201933819] 'process raft request' (duration: 219.903572ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:49.543931Z","caller":"traceutil/trace.go:171","msg":"trace[336143388] linearizableReadLoop","detail":"{readStateIndex:2014; appliedIndex:2013; }","duration":"290.23745ms","start":"2026-03-17T22:01:49.253669Z","end":"2026-03-17T22:01:49.543906Z","steps":["trace[336143388] 'read index received' (duration: 290.063626ms)","trace[336143388] 'applied index is now lower than readState.Index' (duration: 172.724µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:01:49.544102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.410794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:1 size:3017"} {"level":"info","ts":"2026-03-17T22:01:49.544145Z","caller":"traceutil/trace.go:171","msg":"trace[1832677788] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:1; response_revision:1927; }","duration":"290.515026ms","start":"2026-03-17T22:01:49.253617Z","end":"2026-03-17T22:01:49.544132Z","steps":["trace[1832677788] 'agreement among raft nodes before linearized reading' (duration: 290.412544ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:49.544391Z","caller":"traceutil/trace.go:171","msg":"trace[1538377116] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"291.103809ms","start":"2026-03-17T22:01:49.25325Z","end":"2026-03-17T22:01:49.544354Z","steps":["trace[1538377116] 'process raft request' (duration: 290.487825ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:49.584717Z","caller":"traceutil/trace.go:171","msg":"trace[1993449371] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"261.577557ms","start":"2026-03-17T22:01:49.323123Z","end":"2026-03-17T22:01:49.584701Z","steps":["trace[1993449371] 'process raft request' (duration: 259.575591ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:49.584861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.421713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kube-apiserver-legacy-service-account-token-tracking\" ","response":"range_response_count:1 size:370"} {"level":"info","ts":"2026-03-17T22:01:49.584958Z","caller":"traceutil/trace.go:171","msg":"trace[753119713] range","detail":"{range_begin:/registry/configmaps/kube-system/kube-apiserver-legacy-service-account-token-tracking; range_end:; response_count:1; response_revision:1928; }","duration":"278.565986ms","start":"2026-03-17T22:01:49.306374Z","end":"2026-03-17T22:01:49.58494Z","steps":["trace[753119713] 'agreement among raft nodes before linearized reading' (duration: 278.425533ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:49.585108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.665891ms","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:532"} {"level":"warn","ts":"2026-03-17T22:01:49.585145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.952306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T22:01:49.585176Z","caller":"traceutil/trace.go:171","msg":"trace[134906019] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1928; }","duration":"142.007356ms","start":"2026-03-17T22:01:49.44316Z","end":"2026-03-17T22:01:49.585168Z","steps":["trace[134906019] 'agreement among raft nodes before linearized reading' (duration: 141.959575ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:49.585165Z","caller":"traceutil/trace.go:171","msg":"trace[1558789816] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1928; }","duration":"305.742082ms","start":"2026-03-17T22:01:49.27941Z","end":"2026-03-17T22:01:49.585152Z","steps":["trace[1558789816] 'agreement among raft nodes before linearized reading' (duration: 305.571108ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:49.585217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:49.279395Z","time spent":"305.809544ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-03-17T22:01:49.585354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.074933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-public/\" range_end:\"/registry/roles/kube-public0\" limit:500 ","response":"range_response_count:2 size:1073"} {"level":"info","ts":"2026-03-17T22:01:49.585436Z","caller":"traceutil/trace.go:171","msg":"trace[694638860] range","detail":"{range_begin:/registry/roles/kube-public/; range_end:/registry/roles/kube-public0; response_count:2; response_revision:1928; }","duration":"263.206746ms","start":"2026-03-17T22:01:49.322213Z","end":"2026-03-17T22:01:49.58542Z","steps":["trace[694638860] 'agreement among raft nodes before linearized reading' (duration: 262.95027ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:49.58507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.503101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-public/\" range_end:\"/registry/rolebindings/kube-public0\" limit:500 ","response":"range_response_count:2 size:1230"} {"level":"info","ts":"2026-03-17T22:01:49.592653Z","caller":"traceutil/trace.go:171","msg":"trace[1644568417] range","detail":"{range_begin:/registry/rolebindings/kube-public/; range_end:/registry/rolebindings/kube-public0; response_count:2; response_revision:1928; }","duration":"318.491741ms","start":"2026-03-17T22:01:49.269498Z","end":"2026-03-17T22:01:49.587989Z","steps":["trace[1644568417] 'agreement among raft nodes before linearized reading' (duration: 315.380389ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:49.59282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:49.269484Z","time spent":"323.293634ms","remote":"127.0.0.1:34416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":2,"response size":1253,"request content":"key:\"/registry/rolebindings/kube-public/\" range_end:\"/registry/rolebindings/kube-public0\" limit:500 "} {"level":"warn","ts":"2026-03-17T22:01:49.875356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.82507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kube-proxy\" ","response":"range_response_count:1 size:1948"} {"level":"info","ts":"2026-03-17T22:01:49.875441Z","caller":"traceutil/trace.go:171","msg":"trace[1679409287] range","detail":"{range_begin:/registry/configmaps/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1932; }","duration":"184.952983ms","start":"2026-03-17T22:01:49.690469Z","end":"2026-03-17T22:01:49.875422Z","steps":["trace[1679409287] 'range keys from in-memory index tree' (duration: 184.713768ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:49.875488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.525082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kube-root-ca.crt\" ","response":"range_response_count:1 size:1746"} {"level":"info","ts":"2026-03-17T22:01:49.875569Z","caller":"traceutil/trace.go:171","msg":"trace[315850126] range","detail":"{range_begin:/registry/configmaps/kube-system/kube-root-ca.crt; range_end:; response_count:1; response_revision:1932; }","duration":"175.652625ms","start":"2026-03-17T22:01:49.699897Z","end":"2026-03-17T22:01:49.87555Z","steps":["trace[315850126] 'range keys from in-memory index tree' (duration: 175.393899ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:51.806013Z","caller":"traceutil/trace.go:171","msg":"trace[1609020018] linearizableReadLoop","detail":"{readStateIndex:2029; appliedIndex:2028; }","duration":"108.43077ms","start":"2026-03-17T22:01:51.697553Z","end":"2026-03-17T22:01:51.805984Z","steps":["trace[1609020018] 'read index received' (duration: 30.346561ms)","trace[1609020018] 'applied index is now lower than readState.Index' (duration: 78.083089ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T22:01:51.806224Z","caller":"traceutil/trace.go:171","msg":"trace[2000778961] transaction","detail":"{read_only:false; response_revision:1942; number_of_response:1; }","duration":"111.697937ms","start":"2026-03-17T22:01:51.694451Z","end":"2026-03-17T22:01:51.806149Z","steps":["trace[2000778961] 'process raft request' (duration: 33.528786ms)","trace[2000778961] 'compare' (duration: 77.874744ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:01:51.806366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.789249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-x7v9w\" ","response":"range_response_count:1 size:4690"} {"level":"info","ts":"2026-03-17T22:01:51.806449Z","caller":"traceutil/trace.go:171","msg":"trace[843178036] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-x7v9w; range_end:; response_count:1; response_revision:1942; }","duration":"108.910681ms","start":"2026-03-17T22:01:51.697503Z","end":"2026-03-17T22:01:51.806414Z","steps":["trace[843178036] 'agreement among raft nodes before linearized reading' (duration: 108.641865ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:53.107982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.219365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system::extension-apiserver-authentication-reader\" ","response":"range_response_count:1 size:856"} {"level":"warn","ts":"2026-03-17T22:01:53.108015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.567884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kubeadm:nodes-kubeadm-config\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-03-17T22:01:53.108071Z","caller":"traceutil/trace.go:171","msg":"trace[1564252800] range","detail":"{range_begin:/registry/rolebindings/kube-system/system::extension-apiserver-authentication-reader; range_end:; response_count:1; response_revision:1943; }","duration":"108.351138ms","start":"2026-03-17T22:01:52.9997Z","end":"2026-03-17T22:01:53.108051Z","steps":["trace[1564252800] 'range keys from in-memory index tree' (duration: 108.127683ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:53.10809Z","caller":"traceutil/trace.go:171","msg":"trace[273444336] range","detail":"{range_begin:/registry/rolebindings/kube-system/kubeadm:nodes-kubeadm-config; range_end:; response_count:1; response_revision:1943; }","duration":"117.689057ms","start":"2026-03-17T22:01:52.990382Z","end":"2026-03-17T22:01:53.108071Z","steps":["trace[273444336] 'range keys from in-memory index tree' (duration: 117.474022ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:53.858518Z","caller":"traceutil/trace.go:171","msg":"trace[552022491] transaction","detail":"{read_only:false; response_revision:1946; number_of_response:1; }","duration":"162.126708ms","start":"2026-03-17T22:01:53.69637Z","end":"2026-03-17T22:01:53.858496Z","steps":["trace[552022491] 'process raft request' (duration: 161.959724ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:53.918745Z","caller":"traceutil/trace.go:171","msg":"trace[507247652] linearizableReadLoop","detail":"{readStateIndex:2034; appliedIndex:2032; }","duration":"205.816992ms","start":"2026-03-17T22:01:53.712913Z","end":"2026-03-17T22:01:53.91873Z","steps":["trace[507247652] 'read index received' (duration: 145.477519ms)","trace[507247652] 'applied index is now lower than readState.Index' (duration: 60.338493ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T22:01:53.918846Z","caller":"traceutil/trace.go:171","msg":"trace[551074117] transaction","detail":"{read_only:false; response_revision:1947; number_of_response:1; }","duration":"221.794536ms","start":"2026-03-17T22:01:53.697024Z","end":"2026-03-17T22:01:53.918819Z","steps":["trace[551074117] 'process raft request' (duration: 221.599722ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:53.918939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.93662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/extension-apiserver-authentication-reader\" ","response":"range_response_count:1 size:671"} {"level":"info","ts":"2026-03-17T22:01:53.919007Z","caller":"traceutil/trace.go:171","msg":"trace[393983993] range","detail":"{range_begin:/registry/roles/kube-system/extension-apiserver-authentication-reader; range_end:; response_count:1; response_revision:1947; }","duration":"193.016872ms","start":"2026-03-17T22:01:53.725972Z","end":"2026-03-17T22:01:53.918988Z","steps":["trace[393983993] 'agreement among raft nodes before linearized reading' (duration: 192.89989ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:53.919062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.09981ms","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-03-17T22:01:53.919108Z","caller":"traceutil/trace.go:171","msg":"trace[1323384497] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1947; }","duration":"110.185462ms","start":"2026-03-17T22:01:53.808911Z","end":"2026-03-17T22:01:53.919097Z","steps":["trace[1323384497] 'agreement among raft nodes before linearized reading' (duration: 109.964167ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:53.919326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.414196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/cilium-config-agent\" ","response":"range_response_count:1 size:695"} {"level":"info","ts":"2026-03-17T22:01:53.919363Z","caller":"traceutil/trace.go:171","msg":"trace[1571736682] range","detail":"{range_begin:/registry/roles/kube-system/cilium-config-agent; range_end:; response_count:1; response_revision:1947; }","duration":"206.484498ms","start":"2026-03-17T22:01:53.71287Z","end":"2026-03-17T22:01:53.919354Z","steps":["trace[1571736682] 'agreement among raft nodes before linearized reading' (duration: 205.953165ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:54.0427Z","caller":"traceutil/trace.go:171","msg":"trace[1795866326] linearizableReadLoop","detail":"{readStateIndex:2035; appliedIndex:2034; }","duration":"117.704887ms","start":"2026-03-17T22:01:53.924976Z","end":"2026-03-17T22:01:54.042681Z","steps":["trace[1795866326] 'read index received' (duration: 49.172771ms)","trace[1795866326] 'applied index is now lower than readState.Index' (duration: 68.531066ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:01:54.042971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.964794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/cilium-config-agent\" ","response":"range_response_count:1 size:695"} {"level":"info","ts":"2026-03-17T22:01:54.043051Z","caller":"traceutil/trace.go:171","msg":"trace[1397645017] range","detail":"{range_begin:/registry/roles/kube-system/cilium-config-agent; range_end:; response_count:1; response_revision:1948; }","duration":"118.082506ms","start":"2026-03-17T22:01:53.924947Z","end":"2026-03-17T22:01:54.04303Z","steps":["trace[1397645017] 'agreement among raft nodes before linearized reading' (duration: 117.899472ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:54.043177Z","caller":"traceutil/trace.go:171","msg":"trace[1966995271] transaction","detail":"{read_only:false; response_revision:1948; number_of_response:1; }","duration":"119.892539ms","start":"2026-03-17T22:01:53.92326Z","end":"2026-03-17T22:01:54.043153Z","steps":["trace[1966995271] 'process raft request' (duration: 50.934073ms)","trace[1966995271] 'compare' (duration: 68.404793ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:01:54.277097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.48881ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-03-17T22:01:55.107621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.85226ms","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:534"} {"level":"info","ts":"2026-03-17T22:01:55.1082Z","caller":"traceutil/trace.go:171","msg":"trace[1110758844] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1949; }","duration":"173.953685ms","start":"2026-03-17T22:01:54.934229Z","end":"2026-03-17T22:01:55.108183Z","steps":["trace[1110758844] 'range keys from in-memory index tree' (duration: 172.627484ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:55.108222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.959608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:1 size:212"} {"level":"info","ts":"2026-03-17T22:01:55.108663Z","caller":"traceutil/trace.go:171","msg":"trace[1594005108] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:1; response_revision:1949; }","duration":"204.43882ms","start":"2026-03-17T22:01:54.904195Z","end":"2026-03-17T22:01:55.108634Z","steps":["trace[1594005108] 'range keys from in-memory index tree' (duration: 203.205291ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:55.10814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.491688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system:controller:token-cleaner\" ","response":"range_response_count:1 size:670"} {"level":"info","ts":"2026-03-17T22:01:55.108795Z","caller":"traceutil/trace.go:171","msg":"trace[495023414] range","detail":"{range_begin:/registry/roles/kube-system/system:controller:token-cleaner; range_end:; response_count:1; response_revision:1949; }","duration":"207.170063ms","start":"2026-03-17T22:01:54.901609Z","end":"2026-03-17T22:01:55.108779Z","steps":["trace[495023414] 'range keys from in-memory index tree' (duration: 206.015176ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:55.822775Z","caller":"traceutil/trace.go:171","msg":"trace[350848685] linearizableReadLoop","detail":"{readStateIndex:2040; appliedIndex:2039; }","duration":"198.101241ms","start":"2026-03-17T22:01:55.624635Z","end":"2026-03-17T22:01:55.822736Z","steps":["trace[350848685] 'read index received' (duration: 197.786563ms)","trace[350848685] 'applied index is now lower than readState.Index' (duration: 312.728µs)"],"step_count":2} {"level":"info","ts":"2026-03-17T22:01:55.822844Z","caller":"traceutil/trace.go:171","msg":"trace[1118586895] transaction","detail":"{read_only:false; response_revision:1952; number_of_response:1; }","duration":"226.864174ms","start":"2026-03-17T22:01:55.595945Z","end":"2026-03-17T22:01:55.822809Z","steps":["trace[1118586895] 'process raft request' (duration: 226.536117ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:55.823124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.59654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"warn","ts":"2026-03-17T22:01:55.823159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.48908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"warn","ts":"2026-03-17T22:01:55.823257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.99754ms","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:532"} {"level":"info","ts":"2026-03-17T22:01:55.82332Z","caller":"traceutil/trace.go:171","msg":"trace[682998419] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1952; }","duration":"143.121353ms","start":"2026-03-17T22:01:55.680181Z","end":"2026-03-17T22:01:55.823303Z","steps":["trace[682998419] 'agreement among raft nodes before linearized reading' (duration: 142.830406ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:55.82328Z","caller":"traceutil/trace.go:171","msg":"trace[1646106477] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:1952; }","duration":"198.667044ms","start":"2026-03-17T22:01:55.624591Z","end":"2026-03-17T22:01:55.823258Z","steps":["trace[1646106477] 'agreement among raft nodes before linearized reading' (duration: 198.329226ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:55.82322Z","caller":"traceutil/trace.go:171","msg":"trace[1977774434] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:1952; }","duration":"174.753504ms","start":"2026-03-17T22:01:55.648448Z","end":"2026-03-17T22:01:55.823201Z","steps":["trace[1977774434] 'agreement among raft nodes before linearized reading' (duration: 174.561109ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:56.019223Z","caller":"traceutil/trace.go:171","msg":"trace[1665717370] linearizableReadLoop","detail":"{readStateIndex:2041; appliedIndex:2040; }","duration":"168.855795ms","start":"2026-03-17T22:01:55.850344Z","end":"2026-03-17T22:01:56.0192Z","steps":["trace[1665717370] 'read index received' (duration: 76.759338ms)","trace[1665717370] 'applied index is now lower than readState.Index' (duration: 92.095307ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T22:01:56.019327Z","caller":"traceutil/trace.go:171","msg":"trace[1578615228] transaction","detail":"{read_only:false; response_revision:1953; number_of_response:1; }","duration":"191.144967ms","start":"2026-03-17T22:01:55.828142Z","end":"2026-03-17T22:01:56.019287Z","steps":["trace[1578615228] 'process raft request' (duration: 99.012779ms)","trace[1578615228] 'compare' (duration: 91.929444ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:01:56.019495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.134063ms","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-03-17T22:01:56.019551Z","caller":"traceutil/trace.go:171","msg":"trace[673354378] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1953; }","duration":"169.236364ms","start":"2026-03-17T22:01:55.850303Z","end":"2026-03-17T22:01:56.019539Z","steps":["trace[673354378] 'agreement among raft nodes before linearized reading' (duration: 169.06469ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:56.019639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.041869ms","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":"warn","ts":"2026-03-17T22:01:56.019709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.761626ms","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:526"} {"level":"warn","ts":"2026-03-17T22:01:56.019805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.159811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"warn","ts":"2026-03-17T22:01:56.019866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.768774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"info","ts":"2026-03-17T22:01:56.019896Z","caller":"traceutil/trace.go:171","msg":"trace[1648853685] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:1953; }","duration":"104.817646ms","start":"2026-03-17T22:01:55.915072Z","end":"2026-03-17T22:01:56.019889Z","steps":["trace[1648853685] 'agreement among raft nodes before linearized reading' (duration: 104.757474ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:56.019988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.974394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-03-17T22:01:56.02003Z","caller":"traceutil/trace.go:171","msg":"trace[260270285] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1953; }","duration":"127.045247ms","start":"2026-03-17T22:01:55.892974Z","end":"2026-03-17T22:01:56.020019Z","steps":["trace[260270285] 'agreement among raft nodes before linearized reading' (duration: 126.870563ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:56.020554Z","caller":"traceutil/trace.go:171","msg":"trace[141349681] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:1953; }","duration":"122.942971ms","start":"2026-03-17T22:01:55.897593Z","end":"2026-03-17T22:01:56.020536Z","steps":["trace[141349681] 'agreement among raft nodes before linearized reading' (duration: 122.171003ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:56.0198Z","caller":"traceutil/trace.go:171","msg":"trace[169530347] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1953; }","duration":"119.881728ms","start":"2026-03-17T22:01:55.899897Z","end":"2026-03-17T22:01:56.019779Z","steps":["trace[169530347] 'agreement among raft nodes before linearized reading' (duration: 119.598241ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:56.019733Z","caller":"traceutil/trace.go:171","msg":"trace[865806481] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1953; }","duration":"157.170431ms","start":"2026-03-17T22:01:55.86254Z","end":"2026-03-17T22:01:56.019711Z","steps":["trace[865806481] 'agreement among raft nodes before linearized reading' (duration: 156.894275ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:56.403892Z","caller":"traceutil/trace.go:171","msg":"trace[756975086] transaction","detail":"{read_only:false; response_revision:1956; number_of_response:1; }","duration":"378.345352ms","start":"2026-03-17T22:01:56.025525Z","end":"2026-03-17T22:01:56.403871Z","steps":["trace[756975086] 'process raft request' (duration: 378.2394ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:56.404017Z","caller":"traceutil/trace.go:171","msg":"trace[1354424882] linearizableReadLoop","detail":"{readStateIndex:2046; appliedIndex:2042; }","duration":"301.167134ms","start":"2026-03-17T22:01:56.102829Z","end":"2026-03-17T22:01:56.403997Z","steps":["trace[1354424882] 'read index received' (duration: 294.687173ms)","trace[1354424882] 'applied index is now lower than readState.Index' (duration: 6.479101ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:01:56.404037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:56.025516Z","time spent":"378.441385ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T22:01:56.404082Z","caller":"traceutil/trace.go:171","msg":"trace[2074988137] transaction","detail":"{read_only:false; response_revision:1955; number_of_response:1; }","duration":"378.596369ms","start":"2026-03-17T22:01:56.025468Z","end":"2026-03-17T22:01:56.404065Z","steps":["trace[2074988137] 'process raft request' (duration: 372.100217ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:56.404096Z","caller":"traceutil/trace.go:171","msg":"trace[944456048] transaction","detail":"{read_only:false; response_revision:1957; number_of_response:1; }","duration":"377.776199ms","start":"2026-03-17T22:01:56.026309Z","end":"2026-03-17T22:01:56.404085Z","steps":["trace[944456048] 'process raft request' (duration: 377.521103ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:56.405115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:56.025458Z","time spent":"379.306275ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T22:01:56.40532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.755098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:6 size:363686"} {"level":"info","ts":"2026-03-17T22:01:56.404166Z","caller":"traceutil/trace.go:171","msg":"trace[588564641] transaction","detail":"{read_only:false; response_revision:1958; number_of_response:1; }","duration":"377.81261ms","start":"2026-03-17T22:01:56.026339Z","end":"2026-03-17T22:01:56.404152Z","steps":["trace[588564641] 'process raft request' (duration: 377.585385ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:56.405375Z","caller":"traceutil/trace.go:171","msg":"trace[649782686] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:1958; }","duration":"298.877071ms","start":"2026-03-17T22:01:56.106482Z","end":"2026-03-17T22:01:56.40536Z","steps":["trace[649782686] 'agreement among raft nodes before linearized reading' (duration: 298.204055ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:56.405439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:56.026315Z","time spent":"379.08396ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T22:01:56.404244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.632479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-03-17T22:01:56.405546Z","caller":"traceutil/trace.go:171","msg":"trace[346400452] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:1958; }","duration":"376.9634ms","start":"2026-03-17T22:01:56.02857Z","end":"2026-03-17T22:01:56.405533Z","steps":["trace[346400452] 'agreement among raft nodes before linearized reading' (duration: 375.630839ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:56.40558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:56.028551Z","time spent":"377.019051ms","remote":"127.0.0.1:34270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":561,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" "} {"level":"warn","ts":"2026-03-17T22:01:56.404303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.656538ms","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-03-17T22:01:56.40574Z","caller":"traceutil/trace.go:171","msg":"trace[1434550913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1958; }","duration":"359.114332ms","start":"2026-03-17T22:01:56.046616Z","end":"2026-03-17T22:01:56.40573Z","steps":["trace[1434550913] 'agreement among raft nodes before linearized reading' (duration: 357.538135ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:56.405773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:56.046609Z","time spent":"359.154573ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-17T22:01:56.405983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:56.026289Z","time spent":"378.906326ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-17T22:01:57.05853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.466752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/csi-rbd-secret\" ","response":"range_response_count:1 size:880"} {"level":"info","ts":"2026-03-17T22:01:57.058614Z","caller":"traceutil/trace.go:171","msg":"trace[805129386] range","detail":"{range_begin:/registry/secrets/kube-system/csi-rbd-secret; range_end:; response_count:1; response_revision:1960; }","duration":"117.773459ms","start":"2026-03-17T22:01:56.940824Z","end":"2026-03-17T22:01:57.058597Z","steps":["trace[805129386] 'range keys from in-memory index tree' (duration: 117.279177ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:57.966146Z","caller":"traceutil/trace.go:171","msg":"trace[1104131414] linearizableReadLoop","detail":"{readStateIndex:2049; appliedIndex:2048; }","duration":"123.79592ms","start":"2026-03-17T22:01:57.842335Z","end":"2026-03-17T22:01:57.966131Z","steps":["trace[1104131414] 'read index received' (duration: 123.663557ms)","trace[1104131414] 'applied index is now lower than readState.Index' (duration: 131.503µs)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:01:57.966353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.459852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-17T22:01:57.966379Z","caller":"traceutil/trace.go:171","msg":"trace[937352199] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1961; }","duration":"114.513443ms","start":"2026-03-17T22:01:57.85186Z","end":"2026-03-17T22:01:57.966373Z","steps":["trace[937352199] 'agreement among raft nodes before linearized reading' (duration: 114.451911ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:57.9664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.031905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-03-17T22:01:57.966502Z","caller":"traceutil/trace.go:171","msg":"trace[205883864] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/disruption-controller; range_end:; response_count:1; response_revision:1961; }","duration":"124.191369ms","start":"2026-03-17T22:01:57.842292Z","end":"2026-03-17T22:01:57.966483Z","steps":["trace[205883864] 'agreement among raft nodes before linearized reading' (duration: 123.982934ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:57.966516Z","caller":"traceutil/trace.go:171","msg":"trace[591008158] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"137.957682ms","start":"2026-03-17T22:01:57.828522Z","end":"2026-03-17T22:01:57.96648Z","steps":["trace[591008158] 'process raft request' (duration: 137.524602ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:58.38634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.98619ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-17T22:01:58.386623Z","caller":"traceutil/trace.go:171","msg":"trace[207806468] linearizableReadLoop","detail":"{readStateIndex:2050; appliedIndex:2049; }","duration":"305.961538ms","start":"2026-03-17T22:01:58.080646Z","end":"2026-03-17T22:01:58.386607Z","steps":["trace[207806468] 'read index received' (duration: 51.524517ms)","trace[207806468] 'applied index is now lower than readState.Index' (duration: 254.435651ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T22:01:58.386701Z","caller":"traceutil/trace.go:171","msg":"trace[1635819645] transaction","detail":"{read_only:false; response_revision:1962; number_of_response:1; }","duration":"359.690627ms","start":"2026-03-17T22:01:58.026972Z","end":"2026-03-17T22:01:58.386662Z","steps":["trace[1635819645] 'process raft request' (duration: 105.272887ms)","trace[1635819645] 'compare' (duration: 253.707763ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:01:58.386872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.933208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-03-17T22:01:58.386872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:58.026958Z","time spent":"359.82314ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T22:01:58.386905Z","caller":"traceutil/trace.go:171","msg":"trace[1462306199] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1962; }","duration":"280.006439ms","start":"2026-03-17T22:01:58.10689Z","end":"2026-03-17T22:01:58.386896Z","steps":["trace[1462306199] 'agreement among raft nodes before linearized reading' (duration: 279.852786ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:58.38703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.387998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-03-17T22:01:58.387053Z","caller":"traceutil/trace.go:171","msg":"trace[575877025] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:1962; }","duration":"306.447379ms","start":"2026-03-17T22:01:58.080599Z","end":"2026-03-17T22:01:58.387047Z","steps":["trace[575877025] 'agreement among raft nodes before linearized reading' (duration: 306.101941ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:58.387081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:58.080582Z","time spent":"306.4929ms","remote":"127.0.0.1:34270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-03-17T22:01:58.386881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.207043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" ","response":"range_response_count:1 size:232"} {"level":"info","ts":"2026-03-17T22:01:58.387675Z","caller":"traceutil/trace.go:171","msg":"trace[1742644844] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslicemirroring-controller; range_end:; response_count:1; response_revision:1962; }","duration":"304.010612ms","start":"2026-03-17T22:01:58.083632Z","end":"2026-03-17T22:01:58.387642Z","steps":["trace[1742644844] 'agreement among raft nodes before linearized reading' (duration: 303.106791ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:58.387746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:01:58.083624Z","time spent":"304.103415ms","remote":"127.0.0.1:34270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":255,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" "} {"level":"info","ts":"2026-03-17T22:01:58.645979Z","caller":"traceutil/trace.go:171","msg":"trace[2043666665] linearizableReadLoop","detail":"{readStateIndex:2051; appliedIndex:2050; }","duration":"236.584882ms","start":"2026-03-17T22:01:58.409373Z","end":"2026-03-17T22:01:58.645958Z","steps":["trace[2043666665] 'read index received' (duration: 168.16865ms)","trace[2043666665] 'applied index is now lower than readState.Index' (duration: 68.415392ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T22:01:58.646028Z","caller":"traceutil/trace.go:171","msg":"trace[1047139555] transaction","detail":"{read_only:false; response_revision:1963; number_of_response:1; }","duration":"250.880617ms","start":"2026-03-17T22:01:58.395114Z","end":"2026-03-17T22:01:58.645994Z","steps":["trace[1047139555] 'process raft request' (duration: 182.448254ms)","trace[1047139555] 'compare' (duration: 68.29468ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:01:58.646141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.758236ms","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-03-17T22:01:58.646198Z","caller":"traceutil/trace.go:171","msg":"trace[922362821] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1963; }","duration":"236.866329ms","start":"2026-03-17T22:01:58.409322Z","end":"2026-03-17T22:01:58.646189Z","steps":["trace[922362821] 'agreement among raft nodes before linearized reading' (duration: 236.740386ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:58.64621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.382736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-17T22:01:58.646263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.758792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-03-17T22:01:58.646303Z","caller":"traceutil/trace.go:171","msg":"trace[955025582] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:1963; }","duration":"182.850394ms","start":"2026-03-17T22:01:58.46344Z","end":"2026-03-17T22:01:58.64629Z","steps":["trace[955025582] 'agreement among raft nodes before linearized reading' (duration: 182.760292ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:58.646326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.447088ms","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-03-17T22:01:58.646328Z","caller":"traceutil/trace.go:171","msg":"trace[1099273758] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1963; }","duration":"209.531069ms","start":"2026-03-17T22:01:58.436736Z","end":"2026-03-17T22:01:58.646267Z","steps":["trace[1099273758] 'agreement among raft nodes before linearized reading' (duration: 209.365905ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:58.646432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.914434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" ","response":"range_response_count:1 size:232"} {"level":"info","ts":"2026-03-17T22:01:58.64635Z","caller":"traceutil/trace.go:171","msg":"trace[1771681887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1963; }","duration":"186.493179ms","start":"2026-03-17T22:01:58.459849Z","end":"2026-03-17T22:01:58.646343Z","steps":["trace[1771681887] 'agreement among raft nodes before linearized reading' (duration: 186.433248ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:58.646505Z","caller":"traceutil/trace.go:171","msg":"trace[1359359321] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslicemirroring-controller; range_end:; response_count:1; response_revision:1963; }","duration":"173.980536ms","start":"2026-03-17T22:01:58.472488Z","end":"2026-03-17T22:01:58.646469Z","steps":["trace[1359359321] 'agreement among raft nodes before linearized reading' (duration: 173.889274ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:58.848371Z","caller":"traceutil/trace.go:171","msg":"trace[1844484290] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"198.264315ms","start":"2026-03-17T22:01:58.650088Z","end":"2026-03-17T22:01:58.848352Z","steps":["trace[1844484290] 'process raft request' (duration: 114.646046ms)","trace[1844484290] 'compare' (duration: 83.500046ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T22:01:58.848522Z","caller":"traceutil/trace.go:171","msg":"trace[191298832] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"198.311086ms","start":"2026-03-17T22:01:58.650202Z","end":"2026-03-17T22:01:58.848513Z","steps":["trace[191298832] 'process raft request' (duration: 198.113831ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:01:58.848752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.22596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-03-17T22:01:58.848815Z","caller":"traceutil/trace.go:171","msg":"trace[726273521] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:1965; }","duration":"197.330382ms","start":"2026-03-17T22:01:58.651473Z","end":"2026-03-17T22:01:58.848804Z","steps":["trace[726273521] 'agreement among raft nodes before linearized reading' (duration: 197.198269ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:01:58.848618Z","caller":"traceutil/trace.go:171","msg":"trace[939569256] linearizableReadLoop","detail":"{readStateIndex:2053; appliedIndex:2051; }","duration":"197.056147ms","start":"2026-03-17T22:01:58.651498Z","end":"2026-03-17T22:01:58.848554Z","steps":["trace[939569256] 'read index received' (duration: 113.247683ms)","trace[939569256] 'applied index is now lower than readState.Index' (duration: 83.805013ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:01:58.84929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.054186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslicemirroring-controller\" ","response":"range_response_count:1 size:232"} {"level":"info","ts":"2026-03-17T22:01:58.849326Z","caller":"traceutil/trace.go:171","msg":"trace[1521745076] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslicemirroring-controller; range_end:; response_count:1; response_revision:1965; }","duration":"197.107637ms","start":"2026-03-17T22:01:58.652205Z","end":"2026-03-17T22:01:58.849313Z","steps":["trace[1521745076] 'agreement among raft nodes before linearized reading' (duration: 197.039946ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:02:00.18125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.773038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:119 size:91628"} {"level":"info","ts":"2026-03-17T22:02:00.181334Z","caller":"traceutil/trace.go:171","msg":"trace[1093463647] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:119; response_revision:1969; }","duration":"105.873201ms","start":"2026-03-17T22:02:00.075443Z","end":"2026-03-17T22:02:00.181317Z","steps":["trace[1093463647] 'range keys from in-memory index tree' (duration: 105.206734ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:02:00.688169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.803223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-03-17T22:02:00.688265Z","caller":"traceutil/trace.go:171","msg":"trace[1148303632] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replication-controller; range_end:; response_count:1; response_revision:1971; }","duration":"197.950717ms","start":"2026-03-17T22:02:00.490289Z","end":"2026-03-17T22:02:00.688239Z","steps":["trace[1148303632] 'range keys from in-memory index tree' (duration: 197.700151ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:02:00.688776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.431289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:119 size:91628"} {"level":"info","ts":"2026-03-17T22:02:00.688868Z","caller":"traceutil/trace.go:171","msg":"trace[1204809065] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:119; response_revision:1971; }","duration":"207.587143ms","start":"2026-03-17T22:02:00.481263Z","end":"2026-03-17T22:02:00.68885Z","steps":["trace[1204809065] 'range keys from in-memory index tree' (duration: 206.840586ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:02:01.136066Z","caller":"traceutil/trace.go:171","msg":"trace[2130221604] linearizableReadLoop","detail":"{readStateIndex:2064; appliedIndex:2063; }","duration":"113.060429ms","start":"2026-03-17T22:02:01.022983Z","end":"2026-03-17T22:02:01.136044Z","steps":["trace[2130221604] 'read index received' (duration: 112.855564ms)","trace[2130221604] 'applied index is now lower than readState.Index' (duration: 203.995µs)"],"step_count":2} {"level":"info","ts":"2026-03-17T22:02:01.136145Z","caller":"traceutil/trace.go:171","msg":"trace[690858487] transaction","detail":"{read_only:false; response_revision:1975; number_of_response:1; }","duration":"146.545733ms","start":"2026-03-17T22:02:00.989571Z","end":"2026-03-17T22:02:01.136117Z","steps":["trace[690858487] 'process raft request' (duration: 146.333948ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:02:01.136302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.309254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-03-17T22:02:01.136432Z","caller":"traceutil/trace.go:171","msg":"trace[158405618] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:1975; }","duration":"113.486189ms","start":"2026-03-17T22:02:01.02293Z","end":"2026-03-17T22:02:01.136416Z","steps":["trace[158405618] 'agreement among raft nodes before linearized reading' (duration: 113.271104ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:02:01.136905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.082029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-03-17T22:02:01.136947Z","caller":"traceutil/trace.go:171","msg":"trace[332187989] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:1975; }","duration":"107.172221ms","start":"2026-03-17T22:02:01.029764Z","end":"2026-03-17T22:02:01.136936Z","steps":["trace[332187989] 'agreement among raft nodes before linearized reading' (duration: 107.087319ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:02:01.53493Z","caller":"traceutil/trace.go:171","msg":"trace[1472405421] transaction","detail":"{read_only:false; response_revision:1977; number_of_response:1; }","duration":"121.361283ms","start":"2026-03-17T22:02:01.413542Z","end":"2026-03-17T22:02:01.534903Z","steps":["trace[1472405421] 'process raft request' (duration: 108.793869ms)","trace[1472405421] 'compare' (duration: 12.40337ms)"],"step_count":2} {"level":"info","ts":"2026-03-17T22:02:01.535022Z","caller":"traceutil/trace.go:171","msg":"trace[589672225] linearizableReadLoop","detail":"{readStateIndex:2067; appliedIndex:2064; }","duration":"104.018876ms","start":"2026-03-17T22:02:01.430976Z","end":"2026-03-17T22:02:01.534995Z","steps":["trace[589672225] 'read index received' (duration: 11.97849ms)","trace[589672225] 'applied index is now lower than readState.Index' (duration: 92.038496ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:02:01.535215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.223742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:1 size:224"} {"level":"info","ts":"2026-03-17T22:02:01.535266Z","caller":"traceutil/trace.go:171","msg":"trace[225439430] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:1; response_revision:1978; }","duration":"104.324234ms","start":"2026-03-17T22:02:01.430927Z","end":"2026-03-17T22:02:01.535252Z","steps":["trace[225439430] 'agreement among raft nodes before linearized reading' (duration: 104.208721ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:02:01.535357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.857623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/token-cleaner\" ","response":"range_response_count:1 size:191"} {"level":"info","ts":"2026-03-17T22:02:01.535463Z","caller":"traceutil/trace.go:171","msg":"trace[1858674932] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/token-cleaner; range_end:; response_count:1; response_revision:1978; }","duration":"101.017557ms","start":"2026-03-17T22:02:01.43442Z","end":"2026-03-17T22:02:01.535437Z","steps":["trace[1858674932] 'agreement among raft nodes before linearized reading' (duration: 100.789701ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:02:01.535786Z","caller":"traceutil/trace.go:171","msg":"trace[988456753] transaction","detail":"{read_only:false; response_revision:1978; number_of_response:1; }","duration":"122.08901ms","start":"2026-03-17T22:02:01.413678Z","end":"2026-03-17T22:02:01.535767Z","steps":["trace[988456753] 'process raft request' (duration: 121.182599ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:02:01.841287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.869333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:6 size:363686"} {"level":"info","ts":"2026-03-17T22:02:01.841365Z","caller":"traceutil/trace.go:171","msg":"trace[1377661602] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:1978; }","duration":"205.965045ms","start":"2026-03-17T22:02:01.635383Z","end":"2026-03-17T22:02:01.841348Z","steps":["trace[1377661602] 'range keys from in-memory index tree' (duration: 205.480453ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:02:01.841633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.433849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:119 size:91628"} {"level":"info","ts":"2026-03-17T22:02:01.841685Z","caller":"traceutil/trace.go:171","msg":"trace[280674977] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:119; response_revision:1978; }","duration":"198.5114ms","start":"2026-03-17T22:02:01.643161Z","end":"2026-03-17T22:02:01.841673Z","steps":["trace[280674977] 'range keys from in-memory index tree' (duration: 197.726041ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:02:02.510828Z","caller":"traceutil/trace.go:171","msg":"trace[900456525] transaction","detail":"{read_only:false; response_revision:1980; number_of_response:1; }","duration":"100.158466ms","start":"2026-03-17T22:02:02.410645Z","end":"2026-03-17T22:02:02.510803Z","steps":["trace[900456525] 'process raft request' (duration: 99.918901ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:02:05.666588Z","caller":"traceutil/trace.go:171","msg":"trace[1596507711] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"383.34346ms","start":"2026-03-17T22:02:05.283225Z","end":"2026-03-17T22:02:05.666568Z","steps":["trace[1596507711] 'process raft request' (duration: 296.631129ms)","trace[1596507711] 'compare' (duration: 86.272811ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:02:05.666762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:02:05.283205Z","time spent":"383.448323ms","remote":"127.0.0.1:34338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-17T22:02:05.666481Z","caller":"traceutil/trace.go:171","msg":"trace[1321406259] linearizableReadLoop","detail":"{readStateIndex:2082; appliedIndex:2081; }","duration":"301.289698ms","start":"2026-03-17T22:02:05.365158Z","end":"2026-03-17T22:02:05.666448Z","steps":["trace[1321406259] 'read index received' (duration: 214.554456ms)","trace[1321406259] 'applied index is now lower than readState.Index' (duration: 86.733992ms)"],"step_count":2} {"level":"warn","ts":"2026-03-17T22:02:05.667322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.060046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-17T22:02:05.667445Z","caller":"traceutil/trace.go:171","msg":"trace[1264732130] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1992; }","duration":"229.279542ms","start":"2026-03-17T22:02:05.438133Z","end":"2026-03-17T22:02:05.667412Z","steps":["trace[1264732130] 'agreement among raft nodes before linearized reading' (duration: 229.108128ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:02:05.667154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.829561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-sdknc\" ","response":"range_response_count:1 size:13723"} {"level":"info","ts":"2026-03-17T22:02:05.667682Z","caller":"traceutil/trace.go:171","msg":"trace[500441996] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-sdknc; range_end:; response_count:1; response_revision:1992; }","duration":"302.554728ms","start":"2026-03-17T22:02:05.3651Z","end":"2026-03-17T22:02:05.667654Z","steps":["trace[500441996] 'agreement among raft nodes before linearized reading' (duration: 301.566304ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:02:05.667835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-17T22:02:05.365074Z","time spent":"302.742902ms","remote":"127.0.0.1:34256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":13746,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-sdknc\" "} {"level":"info","ts":"2026-03-17T22:02:06.212356Z","caller":"traceutil/trace.go:171","msg":"trace[960365032] transaction","detail":"{read_only:false; response_revision:1993; number_of_response:1; }","duration":"113.385826ms","start":"2026-03-17T22:02:06.098931Z","end":"2026-03-17T22:02:06.212317Z","steps":["trace[960365032] 'process raft request' (duration: 113.209892ms)"],"step_count":1} {"level":"info","ts":"2026-03-17T22:02:08.708205Z","caller":"traceutil/trace.go:171","msg":"trace[683815866] linearizableReadLoop","detail":"{readStateIndex:2093; appliedIndex:2092; }","duration":"127.075466ms","start":"2026-03-17T22:02:08.581117Z","end":"2026-03-17T22:02:08.708192Z","steps":["trace[683815866] 'read index received' (duration: 126.970763ms)","trace[683815866] 'applied index is now lower than readState.Index' (duration: 104.093µs)"],"step_count":2} {"level":"info","ts":"2026-03-17T22:02:08.708256Z","caller":"traceutil/trace.go:171","msg":"trace[300461130] transaction","detail":"{read_only:false; response_revision:2003; number_of_response:1; }","duration":"151.064848ms","start":"2026-03-17T22:02:08.557174Z","end":"2026-03-17T22:02:08.708239Z","steps":["trace[300461130] 'process raft request' (duration: 150.924575ms)"],"step_count":1} {"level":"warn","ts":"2026-03-17T22:02:08.708353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.223109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6k6n5\" ","response":"range_response_count:1 size:18521"} {"level":"info","ts":"2026-03-17T22:02:08.708371Z","caller":"traceutil/trace.go:171","msg":"trace[564091161] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6k6n5; range_end:; response_count:1; response_revision:2003; }","duration":"127.276441ms","start":"2026-03-17T22:02:08.581088Z","end":"2026-03-17T22:02:08.708365Z","steps":["trace[564091161] 'agreement among raft nodes before linearized reading' (duration: 127.156748ms)"],"step_count":1}