{"level":"warn","ts":"2026-01-29T12:53:51.051363Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-01-29T12:53:51.052065Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.74: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://162.253.55.74:2380","--initial-cluster=instance=https://162.253.55.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.74: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-01-29T12:53:51.052212Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-01-29T12:53:51.052276Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.74:2380"]} {"level":"info","ts":"2026-01-29T12:53:51.052301Z","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-01-29T12:53:51.053046Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"]} {"level":"info","ts":"2026-01-29T12:53:51.053197Z","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":2,"max-cpu-available":2,"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://162.253.55.74:2380"],"listen-peer-urls":["https://162.253.55.74:2380"],"advertise-client-urls":["https://162.253.55.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.74: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-01-29T12:53:51.057243Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.76168ms"} {"level":"info","ts":"2026-01-29T12:53:51.070876Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"30aa8136fb61a722","cluster-id":"e7ea3889c4872560"} {"level":"info","ts":"2026-01-29T12:53:51.070919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=()"} {"level":"info","ts":"2026-01-29T12:53:51.070933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became follower at term 0"} {"level":"info","ts":"2026-01-29T12:53:51.071048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 30aa8136fb61a722 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-01-29T12:53:51.071129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became follower at term 1"} {"level":"info","ts":"2026-01-29T12:53:51.071211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=(3506757333007050530)"} {"level":"warn","ts":"2026-01-29T12:53:51.100705Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-01-29T12:53:51.10339Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-01-29T12:53:51.104971Z","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-01-29T12:53:51.106734Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"30aa8136fb61a722","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-01-29T12:53:51.107324Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"30aa8136fb61a722","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-01-29T12:53:51.107419Z","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-01-29T12:53:51.107445Z","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-01-29T12:53:51.107465Z","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-01-29T12:53:51.111405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 switched to configuration voters=(3506757333007050530)"} {"level":"info","ts":"2026-01-29T12:53:51.11239Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e7ea3889c4872560","local-member-id":"30aa8136fb61a722","added-peer-id":"30aa8136fb61a722","added-peer-peer-urls":["https://162.253.55.74:2380"]} {"level":"info","ts":"2026-01-29T12:53:51.112233Z","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-01-29T12:53:51.112706Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"30aa8136fb61a722","initial-advertise-peer-urls":["https://162.253.55.74:2380"],"listen-peer-urls":["https://162.253.55.74:2380"],"advertise-client-urls":["https://162.253.55.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-01-29T12:53:51.112758Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-01-29T12:53:51.112267Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.74:2380"} {"level":"info","ts":"2026-01-29T12:53:51.113371Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.74:2380"} {"level":"info","ts":"2026-01-29T12:53:51.272043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 is starting a new election at term 1"} {"level":"info","ts":"2026-01-29T12:53:51.272237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became pre-candidate at term 1"} {"level":"info","ts":"2026-01-29T12:53:51.272378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 received MsgPreVoteResp from 30aa8136fb61a722 at term 1"} {"level":"info","ts":"2026-01-29T12:53:51.272463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became candidate at term 2"} {"level":"info","ts":"2026-01-29T12:53:51.272504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 received MsgVoteResp from 30aa8136fb61a722 at term 2"} {"level":"info","ts":"2026-01-29T12:53:51.272528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30aa8136fb61a722 became leader at term 2"} {"level":"info","ts":"2026-01-29T12:53:51.272615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 30aa8136fb61a722 elected leader 30aa8136fb61a722 at term 2"} {"level":"info","ts":"2026-01-29T12:53:51.274248Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"30aa8136fb61a722","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.74:2379]}","request-path":"/0/members/30aa8136fb61a722/attributes","cluster-id":"e7ea3889c4872560","publish-timeout":"7s"} {"level":"info","ts":"2026-01-29T12:53:51.27452Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-01-29T12:53:51.274898Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-01-29T12:53:51.275043Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-01-29T12:53:51.278587Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-01-29T12:53:51.278752Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-01-29T12:53:51.278805Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-01-29T12:53:51.280256Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.74:2379"} {"level":"info","ts":"2026-01-29T12:53:51.294398Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e7ea3889c4872560","local-member-id":"30aa8136fb61a722","cluster-version":"3.5"} {"level":"info","ts":"2026-01-29T12:53:51.294558Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-01-29T12:53:51.294665Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-01-29T12:54:20.7551Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12043359919520572248,"retry-timeout":"500ms"} {"level":"info","ts":"2026-01-29T12:54:20.882577Z","caller":"traceutil/trace.go:171","msg":"trace[1060120875] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"772.720056ms","start":"2026-01-29T12:54:20.109837Z","end":"2026-01-29T12:54:20.882557Z","steps":["trace[1060120875] 'process raft request' (duration: 772.582763ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:20.883076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:20.109829Z","time spent":"772.82655ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-29T12:54:20.94733Z","caller":"traceutil/trace.go:171","msg":"trace[1575447535] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:531; }","duration":"692.679933ms","start":"2026-01-29T12:54:20.254629Z","end":"2026-01-29T12:54:20.947309Z","steps":["trace[1575447535] 'read index received' (duration: 627.924551ms)","trace[1575447535] 'applied index is now lower than readState.Index' (duration: 64.754352ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:54:20.94749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.837018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-29T12:54:20.947541Z","caller":"traceutil/trace.go:171","msg":"trace[888744332] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:515; }","duration":"692.92993ms","start":"2026-01-29T12:54:20.254603Z","end":"2026-01-29T12:54:20.947533Z","steps":["trace[888744332] 'agreement among raft nodes before linearized reading' (duration: 692.838077ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:20.947567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:20.25459Z","time spent":"692.9701ms","remote":"127.0.0.1:46958","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-01-29T12:54:20.947594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.555587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4061"} {"level":"info","ts":"2026-01-29T12:54:20.947666Z","caller":"traceutil/trace.go:171","msg":"trace[269620190] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:515; }","duration":"689.639539ms","start":"2026-01-29T12:54:20.258012Z","end":"2026-01-29T12:54:20.947652Z","steps":["trace[269620190] 'agreement among raft nodes before linearized reading' (duration: 689.483545ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:20.947722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:20.258006Z","time spent":"689.70707ms","remote":"127.0.0.1:47142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4084,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-01-29T12:54:23.884413Z","caller":"traceutil/trace.go:171","msg":"trace[16096007] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:537; }","duration":"257.713436ms","start":"2026-01-29T12:54:23.62666Z","end":"2026-01-29T12:54:23.884373Z","steps":["trace[16096007] 'read index received' (duration: 257.590542ms)","trace[16096007] 'applied index is now lower than readState.Index' (duration: 121.984µs)"],"step_count":2} {"level":"info","ts":"2026-01-29T12:54:23.884527Z","caller":"traceutil/trace.go:171","msg":"trace[602706818] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"268.881884ms","start":"2026-01-29T12:54:23.615634Z","end":"2026-01-29T12:54:23.884516Z","steps":["trace[602706818] 'process raft request' (duration: 268.611777ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:23.884689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.010593ms","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-01-29T12:54:23.884721Z","caller":"traceutil/trace.go:171","msg":"trace[516681289] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:521; }","duration":"258.076455ms","start":"2026-01-29T12:54:23.626635Z","end":"2026-01-29T12:54:23.884712Z","steps":["trace[516681289] 'agreement among raft nodes before linearized reading' (duration: 258.005993ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:23.884912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.22792ms","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-01-29T12:54:23.884995Z","caller":"traceutil/trace.go:171","msg":"trace[2052484535] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:521; }","duration":"246.376614ms","start":"2026-01-29T12:54:23.638602Z","end":"2026-01-29T12:54:23.884978Z","steps":["trace[2052484535] 'agreement among raft nodes before linearized reading' (duration: 246.23531ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:54:28.28232Z","caller":"traceutil/trace.go:171","msg":"trace[1828046930] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:552; }","duration":"380.125263ms","start":"2026-01-29T12:54:27.902172Z","end":"2026-01-29T12:54:28.282297Z","steps":["trace[1828046930] 'read index received' (duration: 379.931158ms)","trace[1828046930] 'applied index is now lower than readState.Index' (duration: 193.205µs)"],"step_count":2} {"level":"info","ts":"2026-01-29T12:54:28.282607Z","caller":"traceutil/trace.go:171","msg":"trace[457169187] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"382.178023ms","start":"2026-01-29T12:54:27.900417Z","end":"2026-01-29T12:54:28.282595Z","steps":["trace[457169187] 'process raft request' (duration: 381.747352ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:28.282719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:27.90039Z","time spent":"382.245115ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-01-29T12:54:28.282923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.744288ms","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-01-29T12:54:28.282957Z","caller":"traceutil/trace.go:171","msg":"trace[1805058214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:535; }","duration":"380.79133ms","start":"2026-01-29T12:54:27.902155Z","end":"2026-01-29T12:54:28.282946Z","steps":["trace[1805058214] 'agreement among raft nodes before linearized reading' (duration: 380.724558ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:28.282986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:27.902147Z","time spent":"380.832121ms","remote":"127.0.0.1:47240","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-01-29T12:54:28.283166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.02157ms","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-01-29T12:54:28.283195Z","caller":"traceutil/trace.go:171","msg":"trace[1839631653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:535; }","duration":"380.069531ms","start":"2026-01-29T12:54:27.903117Z","end":"2026-01-29T12:54:28.283186Z","steps":["trace[1839631653] 'agreement among raft nodes before linearized reading' (duration: 380.01865ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:28.283219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:27.903111Z","time spent":"380.102803ms","remote":"127.0.0.1:47240","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-01-29T12:54:28.283549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.330461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cjgfg\" ","response":"range_response_count:1 size:16652"} {"level":"info","ts":"2026-01-29T12:54:28.283581Z","caller":"traceutil/trace.go:171","msg":"trace[1564379970] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cjgfg; range_end:; response_count:1; response_revision:535; }","duration":"217.391183ms","start":"2026-01-29T12:54:28.066182Z","end":"2026-01-29T12:54:28.283573Z","steps":["trace[1564379970] 'agreement among raft nodes before linearized reading' (duration: 217.28587ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:30.649383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.595285ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-01-29T12:54:30.649479Z","caller":"traceutil/trace.go:171","msg":"trace[1483948397] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"399.523676ms","start":"2026-01-29T12:54:30.249938Z","end":"2026-01-29T12:54:30.649462Z","steps":["trace[1483948397] 'process raft request' (duration: 204.661034ms)","trace[1483948397] 'compare' (duration: 194.323969ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:54:30.649599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:30.249926Z","time spent":"399.583208ms","remote":"127.0.0.1:46998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-01-29T12:54:30.653461Z","caller":"traceutil/trace.go:171","msg":"trace[1565354031] linearizableReadLoop","detail":"{readStateIndex:575; appliedIndex:573; }","duration":"401.036373ms","start":"2026-01-29T12:54:30.252391Z","end":"2026-01-29T12:54:30.653428Z","steps":["trace[1565354031] 'read index received' (duration: 202.218844ms)","trace[1565354031] 'applied index is now lower than readState.Index' (duration: 198.816959ms)"],"step_count":2} {"level":"info","ts":"2026-01-29T12:54:30.65444Z","caller":"traceutil/trace.go:171","msg":"trace[1489476075] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"401.366612ms","start":"2026-01-29T12:54:30.253064Z","end":"2026-01-29T12:54:30.654431Z","steps":["trace[1489476075] 'process raft request' (duration: 400.325505ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:30.654519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:30.253058Z","time spent":"401.423524ms","remote":"127.0.0.1:46998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-01-29T12:54:30.654655Z","caller":"traceutil/trace.go:171","msg":"trace[1101535668] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"402.494989ms","start":"2026-01-29T12:54:30.252154Z","end":"2026-01-29T12:54:30.654649Z","steps":["trace[1101535668] 'process raft request' (duration: 401.167976ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:30.654706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:30.252147Z","time spent":"402.528421ms","remote":"127.0.0.1:46998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-01-29T12:54:30.654947Z","caller":"traceutil/trace.go:171","msg":"trace[1323803918] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"231.243447ms","start":"2026-01-29T12:54:30.423679Z","end":"2026-01-29T12:54:30.654923Z","steps":["trace[1323803918] 'process raft request' (duration: 229.729599ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:30.655137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.731166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-29T12:54:30.655181Z","caller":"traceutil/trace.go:171","msg":"trace[849021425] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:558; }","duration":"402.799099ms","start":"2026-01-29T12:54:30.252375Z","end":"2026-01-29T12:54:30.655174Z","steps":["trace[849021425] 'agreement among raft nodes before linearized reading' (duration: 402.678776ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:30.6552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:30.252368Z","time spent":"402.827329ms","remote":"127.0.0.1:46964","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-01-29T12:54:30.659879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.278918ms","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-01-29T12:54:30.659915Z","caller":"traceutil/trace.go:171","msg":"trace[1425300316] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:559; }","duration":"370.34002ms","start":"2026-01-29T12:54:30.289567Z","end":"2026-01-29T12:54:30.659907Z","steps":["trace[1425300316] 'agreement among raft nodes before linearized reading' (duration: 369.820637ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:30.659951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:30.289556Z","time spent":"370.389541ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-01-29T12:54:30.660114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.12517ms","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-01-29T12:54:30.660133Z","caller":"traceutil/trace.go:171","msg":"trace[1357932413] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:559; }","duration":"359.158612ms","start":"2026-01-29T12:54:30.300968Z","end":"2026-01-29T12:54:30.660127Z","steps":["trace[1357932413] 'agreement among raft nodes before linearized reading' (duration: 359.09031ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:30.66047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.547951ms","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-01-29T12:54:30.660516Z","caller":"traceutil/trace.go:171","msg":"trace[1082943733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:559; }","duration":"367.625282ms","start":"2026-01-29T12:54:30.292879Z","end":"2026-01-29T12:54:30.660504Z","steps":["trace[1082943733] 'agreement among raft nodes before linearized reading' (duration: 367.489869ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:30.660541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:30.292856Z","time spent":"367.680184ms","remote":"127.0.0.1:47240","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-01-29T12:54:30.660149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:30.300961Z","time spent":"359.184742ms","remote":"127.0.0.1:47240","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-01-29T12:54:42.877008Z","caller":"traceutil/trace.go:171","msg":"trace[1692003910] linearizableReadLoop","detail":"{readStateIndex:733; appliedIndex:732; }","duration":"136.881587ms","start":"2026-01-29T12:54:42.7401Z","end":"2026-01-29T12:54:42.876981Z","steps":["trace[1692003910] 'read index received' (duration: 136.706913ms)","trace[1692003910] 'applied index is now lower than readState.Index' (duration: 174.174µs)"],"step_count":2} {"level":"info","ts":"2026-01-29T12:54:42.877173Z","caller":"traceutil/trace.go:171","msg":"trace[1057989338] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"146.59761ms","start":"2026-01-29T12:54:42.730564Z","end":"2026-01-29T12:54:42.877161Z","steps":["trace[1057989338] 'process raft request' (duration: 146.312972ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:42.877338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.969829ms","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-01-29T12:54:42.877402Z","caller":"traceutil/trace.go:171","msg":"trace[562259838] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:710; }","duration":"137.045211ms","start":"2026-01-29T12:54:42.740339Z","end":"2026-01-29T12:54:42.877384Z","steps":["trace[562259838] 'agreement among raft nodes before linearized reading' (duration: 136.890237ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:42.877517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.3945ms","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-01-29T12:54:42.877538Z","caller":"traceutil/trace.go:171","msg":"trace[1876775226] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:710; }","duration":"137.444032ms","start":"2026-01-29T12:54:42.740089Z","end":"2026-01-29T12:54:42.877533Z","steps":["trace[1876775226] 'agreement among raft nodes before linearized reading' (duration: 137.35205ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:43.615856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.993627ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-01-29T12:54:43.61598Z","caller":"traceutil/trace.go:171","msg":"trace[1962682338] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"461.839498ms","start":"2026-01-29T12:54:43.15413Z","end":"2026-01-29T12:54:43.61597Z","steps":["trace[1962682338] 'process raft request' (duration: 461.806747ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:43.616013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:43.154122Z","time spent":"461.876749ms","remote":"127.0.0.1:47026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":723,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-01-29T12:54:43.616196Z","caller":"traceutil/trace.go:171","msg":"trace[409980831] linearizableReadLoop","detail":"{readStateIndex:735; appliedIndex:734; }","duration":"592.227074ms","start":"2026-01-29T12:54:43.023949Z","end":"2026-01-29T12:54:43.616176Z","steps":["trace[409980831] 'read index received' (duration: 473.821036ms)","trace[409980831] 'applied index is now lower than readState.Index' (duration: 118.404288ms)"],"step_count":2} {"level":"info","ts":"2026-01-29T12:54:43.616268Z","caller":"traceutil/trace.go:171","msg":"trace[855837403] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"734.748491ms","start":"2026-01-29T12:54:42.881512Z","end":"2026-01-29T12:54:43.616261Z","steps":["trace[855837403] 'process raft request' (duration: 616.294762ms)","trace[855837403] 'compare' (duration: 117.929606ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:54:43.616353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:42.881506Z","time spent":"734.778553ms","remote":"127.0.0.1:47240","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-01-29T12:54:43.616358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.691178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-b5wx2\" ","response":"range_response_count:1 size:4820"} {"level":"info","ts":"2026-01-29T12:54:43.616378Z","caller":"traceutil/trace.go:171","msg":"trace[41745030] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-b5wx2; range_end:; response_count:1; response_revision:713; }","duration":"462.72861ms","start":"2026-01-29T12:54:43.153644Z","end":"2026-01-29T12:54:43.616372Z","steps":["trace[41745030] 'agreement among raft nodes before linearized reading' (duration: 462.648818ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:43.616394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:43.153619Z","time spent":"462.771451ms","remote":"127.0.0.1:47152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":4843,"request content":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-b5wx2\" "} {"level":"warn","ts":"2026-01-29T12:54:43.616504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.555792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-01-29T12:54:43.616518Z","caller":"traceutil/trace.go:171","msg":"trace[1648260598] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:713; }","duration":"592.602024ms","start":"2026-01-29T12:54:43.023912Z","end":"2026-01-29T12:54:43.616514Z","steps":["trace[1648260598] 'agreement among raft nodes before linearized reading' (duration: 592.561263ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:43.616531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:43.023895Z","time spent":"592.632784ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-01-29T12:54:43.616591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.203737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-29T12:54:43.616612Z","caller":"traceutil/trace.go:171","msg":"trace[1726446294] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:713; }","duration":"368.248548ms","start":"2026-01-29T12:54:43.248356Z","end":"2026-01-29T12:54:43.616605Z","steps":["trace[1726446294] 'agreement among raft nodes before linearized reading' (duration: 368.209737ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:43.616626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:43.248344Z","time spent":"368.280039ms","remote":"127.0.0.1:46958","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-01-29T12:54:44.407618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.770515ms","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-01-29T12:54:44.407754Z","caller":"traceutil/trace.go:171","msg":"trace[1388012638] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:713; }","duration":"555.917029ms","start":"2026-01-29T12:54:43.851815Z","end":"2026-01-29T12:54:44.407732Z","steps":["trace[1388012638] 'range keys from in-memory index tree' (duration: 555.752975ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:54:44.408864Z","caller":"traceutil/trace.go:171","msg":"trace[2057849596] linearizableReadLoop","detail":"{readStateIndex:737; appliedIndex:736; }","duration":"159.495ms","start":"2026-01-29T12:54:44.24935Z","end":"2026-01-29T12:54:44.408845Z","steps":["trace[2057849596] 'read index received' (duration: 74.498104ms)","trace[2057849596] 'applied index is now lower than readState.Index' (duration: 84.995826ms)"],"step_count":2} {"level":"info","ts":"2026-01-29T12:54:44.409329Z","caller":"traceutil/trace.go:171","msg":"trace[1977229422] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"789.36665ms","start":"2026-01-29T12:54:43.61992Z","end":"2026-01-29T12:54:44.409287Z","steps":["trace[1977229422] 'process raft request' (duration: 704.005195ms)","trace[1977229422] 'compare' (duration: 84.814981ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:54:44.409447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:43.619911Z","time spent":"789.462303ms","remote":"127.0.0.1:47240","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-01-29T12:54:44.409705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.34349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-29T12:54:44.40975Z","caller":"traceutil/trace.go:171","msg":"trace[1490899902] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:714; }","duration":"160.412652ms","start":"2026-01-29T12:54:44.249323Z","end":"2026-01-29T12:54:44.409735Z","steps":["trace[1490899902] 'agreement among raft nodes before linearized reading' (duration: 160.338521ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:44.808537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.037508ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-01-29T12:54:44.808613Z","caller":"traceutil/trace.go:171","msg":"trace[1806048878] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"388.406358ms","start":"2026-01-29T12:54:44.420192Z","end":"2026-01-29T12:54:44.808598Z","steps":["trace[1806048878] 'process raft request' (duration: 170.234037ms)","trace[1806048878] 'compare' (duration: 217.931965ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:54:44.808654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:44.420179Z","time spent":"388.45657ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-29T12:54:48.671612Z","caller":"traceutil/trace.go:171","msg":"trace[849149361] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"243.80858ms","start":"2026-01-29T12:54:48.427786Z","end":"2026-01-29T12:54:48.671595Z","steps":["trace[849149361] 'process raft request' (duration: 243.604415ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:49.374599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.592466ms","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-01-29T12:54:49.374662Z","caller":"traceutil/trace.go:171","msg":"trace[586660075] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:728; }","duration":"550.693699ms","start":"2026-01-29T12:54:48.823957Z","end":"2026-01-29T12:54:49.374651Z","steps":["trace[586660075] 'range keys from in-memory index tree' (duration: 550.473704ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:49.374691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:48.823943Z","time spent":"550.742ms","remote":"127.0.0.1:47240","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-01-29T12:54:49.374849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.921472ms","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-01-29T12:54:49.374863Z","caller":"traceutil/trace.go:171","msg":"trace[1738498113] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:728; }","duration":"478.964764ms","start":"2026-01-29T12:54:48.895893Z","end":"2026-01-29T12:54:49.374858Z","steps":["trace[1738498113] 'range keys from in-memory index tree' (duration: 478.855231ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:49.374876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:48.895879Z","time spent":"478.992435ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-01-29T12:54:49.374987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.197789ms","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-01-29T12:54:49.374999Z","caller":"traceutil/trace.go:171","msg":"trace[394320837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:728; }","duration":"393.23417ms","start":"2026-01-29T12:54:48.981761Z","end":"2026-01-29T12:54:49.374995Z","steps":["trace[394320837] 'range keys from in-memory index tree' (duration: 393.145818ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:49.375011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:48.981748Z","time spent":"393.25962ms","remote":"127.0.0.1:47240","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-01-29T12:54:49.375124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.234673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-29T12:54:49.375137Z","caller":"traceutil/trace.go:171","msg":"trace[1478326789] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:728; }","duration":"126.272354ms","start":"2026-01-29T12:54:49.248861Z","end":"2026-01-29T12:54:49.375133Z","steps":["trace[1478326789] 'range keys from in-memory index tree' (duration: 126.194932ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:54:49.549459Z","caller":"traceutil/trace.go:171","msg":"trace[395889357] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"170.381852ms","start":"2026-01-29T12:54:49.379055Z","end":"2026-01-29T12:54:49.549436Z","steps":["trace[395889357] 'process raft request' (duration: 170.216628ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:54:49.553627Z","caller":"traceutil/trace.go:171","msg":"trace[874271911] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"162.29284ms","start":"2026-01-29T12:54:49.39132Z","end":"2026-01-29T12:54:49.553613Z","steps":["trace[874271911] 'process raft request' (duration: 162.260409ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:54:49.554347Z","caller":"traceutil/trace.go:171","msg":"trace[945918673] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"174.794021ms","start":"2026-01-29T12:54:49.379539Z","end":"2026-01-29T12:54:49.554333Z","steps":["trace[945918673] 'process raft request' (duration: 173.976231ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:49.844047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.399702ms","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-01-29T12:54:49.844102Z","caller":"traceutil/trace.go:171","msg":"trace[1231560410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:731; }","duration":"211.501874ms","start":"2026-01-29T12:54:49.632588Z","end":"2026-01-29T12:54:49.84409Z","steps":["trace[1231560410] 'range keys from in-memory index tree' (duration: 211.242638ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:54:53.790545Z","caller":"traceutil/trace.go:171","msg":"trace[504113824] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"210.45631ms","start":"2026-01-29T12:54:53.580074Z","end":"2026-01-29T12:54:53.79053Z","steps":["trace[504113824] 'process raft request' (duration: 210.374068ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:54:53.79118Z","caller":"traceutil/trace.go:171","msg":"trace[230365278] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"161.339946ms","start":"2026-01-29T12:54:53.629824Z","end":"2026-01-29T12:54:53.791164Z","steps":["trace[230365278] 'process raft request' (duration: 161.220653ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:54:58.214772Z","caller":"traceutil/trace.go:171","msg":"trace[807927525] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"410.005476ms","start":"2026-01-29T12:54:57.80475Z","end":"2026-01-29T12:54:58.214756Z","steps":["trace[807927525] 'process raft request' (duration: 409.917404ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:58.214881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:57.804739Z","time spent":"410.088038ms","remote":"127.0.0.1:47240","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-01-29T12:54:58.215234Z","caller":"traceutil/trace.go:171","msg":"trace[1387642101] linearizableReadLoop","detail":"{readStateIndex:784; appliedIndex:784; }","duration":"410.318124ms","start":"2026-01-29T12:54:57.804908Z","end":"2026-01-29T12:54:58.215226Z","steps":["trace[1387642101] 'read index received' (duration: 410.315364ms)","trace[1387642101] 'applied index is now lower than readState.Index' (duration: 2.3µs)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:54:58.215329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.415566ms","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-01-29T12:54:58.215348Z","caller":"traceutil/trace.go:171","msg":"trace[2130731420] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:757; }","duration":"410.447878ms","start":"2026-01-29T12:54:57.804894Z","end":"2026-01-29T12:54:58.215342Z","steps":["trace[2130731420] 'agreement among raft nodes before linearized reading' (duration: 410.375086ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:58.215368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:57.804889Z","time spent":"410.474848ms","remote":"127.0.0.1:47240","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":"info","ts":"2026-01-29T12:54:58.42098Z","caller":"traceutil/trace.go:171","msg":"trace[1678022022] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"371.002686ms","start":"2026-01-29T12:54:58.049958Z","end":"2026-01-29T12:54:58.420961Z","steps":["trace[1678022022] 'process raft request' (duration: 334.071317ms)","trace[1678022022] 'compare' (duration: 36.807746ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:54:58.421092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:58.049943Z","time spent":"371.089869ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-29T12:54:58.421092Z","caller":"traceutil/trace.go:171","msg":"trace[1831816800] linearizableReadLoop","detail":"{readStateIndex:786; appliedIndex:784; }","duration":"205.815854ms","start":"2026-01-29T12:54:58.215258Z","end":"2026-01-29T12:54:58.421073Z","steps":["trace[1831816800] 'read index received' (duration: 168.779242ms)","trace[1831816800] 'applied index is now lower than readState.Index' (duration: 37.036072ms)"],"step_count":2} {"level":"info","ts":"2026-01-29T12:54:58.421252Z","caller":"traceutil/trace.go:171","msg":"trace[368584038] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"248.966818ms","start":"2026-01-29T12:54:58.172279Z","end":"2026-01-29T12:54:58.421246Z","steps":["trace[368584038] 'process raft request' (duration: 248.64617ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:58.421384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.620321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-01-29T12:54:58.421411Z","caller":"traceutil/trace.go:171","msg":"trace[1484440840] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:759; }","duration":"557.649381ms","start":"2026-01-29T12:54:57.863754Z","end":"2026-01-29T12:54:58.421404Z","steps":["trace[1484440840] 'agreement among raft nodes before linearized reading' (duration: 557.60305ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:58.421433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:57.863731Z","time spent":"557.696483ms","remote":"127.0.0.1:47238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-01-29T12:54:58.421549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.906584ms","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-01-29T12:54:58.421574Z","caller":"traceutil/trace.go:171","msg":"trace[653798640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:759; }","duration":"550.982926ms","start":"2026-01-29T12:54:57.870584Z","end":"2026-01-29T12:54:58.421567Z","steps":["trace[653798640] 'agreement among raft nodes before linearized reading' (duration: 550.886654ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:58.421596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:57.870564Z","time spent":"551.024547ms","remote":"127.0.0.1:47240","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-01-29T12:54:58.898288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.775143ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-01-29T12:54:58.898413Z","caller":"traceutil/trace.go:171","msg":"trace[1857358173] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"472.075262ms","start":"2026-01-29T12:54:58.426326Z","end":"2026-01-29T12:54:58.898401Z","steps":["trace[1857358173] 'process raft request' (duration: 472.031141ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:58.898477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:58.426308Z","time spent":"472.132673ms","remote":"127.0.0.1:47240","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-01-29T12:54:58.898699Z","caller":"traceutil/trace.go:171","msg":"trace[421037800] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"680.801608ms","start":"2026-01-29T12:54:58.217888Z","end":"2026-01-29T12:54:58.89869Z","steps":["trace[421037800] 'process raft request' (duration: 335.554674ms)","trace[421037800] 'compare' (duration: 344.631759ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:54:58.898741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:58.217877Z","time spent":"680.842939ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-29T12:54:58.898815Z","caller":"traceutil/trace.go:171","msg":"trace[1132299566] linearizableReadLoop","detail":"{readStateIndex:787; appliedIndex:786; }","duration":"477.676011ms","start":"2026-01-29T12:54:58.421133Z","end":"2026-01-29T12:54:58.898809Z","steps":["trace[1132299566] 'read index received' (duration: 132.319614ms)","trace[1132299566] 'applied index is now lower than readState.Index' (duration: 345.355677ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:54:58.898935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.906093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-29T12:54:58.898954Z","caller":"traceutil/trace.go:171","msg":"trace[582185657] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:761; }","duration":"648.947145ms","start":"2026-01-29T12:54:58.25Z","end":"2026-01-29T12:54:58.898947Z","steps":["trace[582185657] 'agreement among raft nodes before linearized reading' (duration: 648.902364ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:54:58.898974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:54:58.249991Z","time spent":"648.979075ms","remote":"127.0.0.1:46958","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-01-29T12:54:58.89914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.957891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-01-29T12:54:58.899159Z","caller":"traceutil/trace.go:171","msg":"trace[1435153256] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:761; }","duration":"133.024962ms","start":"2026-01-29T12:54:58.766128Z","end":"2026-01-29T12:54:58.899153Z","steps":["trace[1435153256] 'agreement among raft nodes before linearized reading' (duration: 132.92861ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:54:59.175009Z","caller":"traceutil/trace.go:171","msg":"trace[1614544497] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"272.969584ms","start":"2026-01-29T12:54:58.902023Z","end":"2026-01-29T12:54:59.174993Z","steps":["trace[1614544497] 'process raft request' (duration: 270.903763ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:55:08.603231Z","caller":"traceutil/trace.go:171","msg":"trace[1782684483] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"131.940564ms","start":"2026-01-29T12:55:08.471267Z","end":"2026-01-29T12:55:08.603208Z","steps":["trace[1782684483] 'process raft request' (duration: 131.77826ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:55:10.0232Z","caller":"traceutil/trace.go:171","msg":"trace[2000376352] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:819; }","duration":"263.823937ms","start":"2026-01-29T12:55:09.759351Z","end":"2026-01-29T12:55:10.023175Z","steps":["trace[2000376352] 'read index received' (duration: 263.619741ms)","trace[2000376352] 'applied index is now lower than readState.Index' (duration: 203.076µs)"],"step_count":2} {"level":"info","ts":"2026-01-29T12:55:10.024033Z","caller":"traceutil/trace.go:171","msg":"trace[1346810554] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"292.85218ms","start":"2026-01-29T12:55:09.731148Z","end":"2026-01-29T12:55:10.024001Z","steps":["trace[1346810554] 'process raft request' (duration: 291.833455ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:10.023382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.017542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-01-29T12:55:10.029081Z","caller":"traceutil/trace.go:171","msg":"trace[2134185526] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:791; }","duration":"269.833866ms","start":"2026-01-29T12:55:09.759233Z","end":"2026-01-29T12:55:10.029067Z","steps":["trace[2134185526] 'agreement among raft nodes before linearized reading' (duration: 264.036222ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:11.054962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.79474ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-01-29T12:55:11.055093Z","caller":"traceutil/trace.go:171","msg":"trace[1518770964] linearizableReadLoop","detail":"{readStateIndex:821; appliedIndex:820; }","duration":"786.807707ms","start":"2026-01-29T12:55:10.268246Z","end":"2026-01-29T12:55:11.055054Z","steps":["trace[1518770964] 'read index received' (duration: 166.859963ms)","trace[1518770964] 'applied index is now lower than readState.Index' (duration: 619.946304ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:55:11.055504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.245198ms","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-01-29T12:55:11.055552Z","caller":"traceutil/trace.go:171","msg":"trace[1290504766] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:791; }","duration":"787.33126ms","start":"2026-01-29T12:55:10.268207Z","end":"2026-01-29T12:55:11.055538Z","steps":["trace[1290504766] 'agreement among raft nodes before linearized reading' (duration: 787.180206ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:11.05559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:10.268189Z","time spent":"787.393171ms","remote":"127.0.0.1:47240","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-01-29T12:55:11.055786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.566372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-01-29T12:55:11.055821Z","caller":"traceutil/trace.go:171","msg":"trace[1601240505] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:791; }","duration":"202.640154ms","start":"2026-01-29T12:55:10.853172Z","end":"2026-01-29T12:55:11.055812Z","steps":["trace[1601240505] 'agreement among raft nodes before linearized reading' (duration: 202.585053ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:11.056247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.582638ms","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-01-29T12:55:11.056288Z","caller":"traceutil/trace.go:171","msg":"trace[1898650953] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:791; }","duration":"109.65071ms","start":"2026-01-29T12:55:10.946628Z","end":"2026-01-29T12:55:11.056279Z","steps":["trace[1898650953] 'agreement among raft nodes before linearized reading' (duration: 109.562138ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:11.056617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.26187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-01-29T12:55:11.056939Z","caller":"traceutil/trace.go:171","msg":"trace[655420714] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:791; }","duration":"154.595159ms","start":"2026-01-29T12:55:10.902329Z","end":"2026-01-29T12:55:11.056924Z","steps":["trace[655420714] 'agreement among raft nodes before linearized reading' (duration: 154.261451ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:55:11.287161Z","caller":"traceutil/trace.go:171","msg":"trace[1975592011] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"226.335224ms","start":"2026-01-29T12:55:11.060807Z","end":"2026-01-29T12:55:11.287142Z","steps":["trace[1975592011] 'process raft request' (duration: 226.15956ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:55:11.45578Z","caller":"traceutil/trace.go:171","msg":"trace[23916977] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"394.719806ms","start":"2026-01-29T12:55:11.060985Z","end":"2026-01-29T12:55:11.455705Z","steps":["trace[23916977] 'process raft request' (duration: 321.601935ms)","trace[23916977] 'compare' (duration: 72.878465ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:55:11.456176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:11.060979Z","time spent":"395.082904ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-29T12:55:11.457389Z","caller":"traceutil/trace.go:171","msg":"trace[1369478297] linearizableReadLoop","detail":"{readStateIndex:824; appliedIndex:822; }","duration":"203.955807ms","start":"2026-01-29T12:55:11.253407Z","end":"2026-01-29T12:55:11.457363Z","steps":["trace[1369478297] 'read index received' (duration: 34.388156ms)","trace[1369478297] 'applied index is now lower than readState.Index' (duration: 169.565761ms)"],"step_count":2} {"level":"info","ts":"2026-01-29T12:55:11.457759Z","caller":"traceutil/trace.go:171","msg":"trace[437863513] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"396.273555ms","start":"2026-01-29T12:55:11.061472Z","end":"2026-01-29T12:55:11.457746Z","steps":["trace[437863513] 'process raft request' (duration: 394.127912ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:11.458029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:11.061465Z","time spent":"396.392768ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-01-29T12:55:11.458364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.947342ms","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-01-29T12:55:11.458433Z","caller":"traceutil/trace.go:171","msg":"trace[620453782] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:794; }","duration":"205.093745ms","start":"2026-01-29T12:55:11.253324Z","end":"2026-01-29T12:55:11.458418Z","steps":["trace[620453782] 'agreement among raft nodes before linearized reading' (duration: 204.89126ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:11.45867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.092535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-29T12:55:11.458706Z","caller":"traceutil/trace.go:171","msg":"trace[462709996] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:794; }","duration":"205.145977ms","start":"2026-01-29T12:55:11.253551Z","end":"2026-01-29T12:55:11.458697Z","steps":["trace[462709996] 'agreement among raft nodes before linearized reading' (duration: 205.063545ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:55:21.75931Z","caller":"traceutil/trace.go:171","msg":"trace[526243994] linearizableReadLoop","detail":"{readStateIndex:906; appliedIndex:905; }","duration":"219.856553ms","start":"2026-01-29T12:55:21.539437Z","end":"2026-01-29T12:55:21.759293Z","steps":["trace[526243994] 'read index received' (duration: 219.71882ms)","trace[526243994] 'applied index is now lower than readState.Index' (duration: 137.143µs)"],"step_count":2} {"level":"info","ts":"2026-01-29T12:55:21.759394Z","caller":"traceutil/trace.go:171","msg":"trace[610564880] transaction","detail":"{read_only:false; response_revision:872; number_of_response:1; }","duration":"235.258776ms","start":"2026-01-29T12:55:21.52413Z","end":"2026-01-29T12:55:21.759389Z","steps":["trace[610564880] 'process raft request' (duration: 235.064362ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:21.759515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.058558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-29T12:55:21.75953Z","caller":"traceutil/trace.go:171","msg":"trace[86347220] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:872; }","duration":"220.111679ms","start":"2026-01-29T12:55:21.539414Z","end":"2026-01-29T12:55:21.759526Z","steps":["trace[86347220] 'agreement among raft nodes before linearized reading' (duration: 220.060878ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:21.759634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.530351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-29T12:55:21.759648Z","caller":"traceutil/trace.go:171","msg":"trace[1504991284] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:872; }","duration":"206.570053ms","start":"2026-01-29T12:55:21.553072Z","end":"2026-01-29T12:55:21.759642Z","steps":["trace[1504991284] 'agreement among raft nodes before linearized reading' (duration: 206.548902ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:21.759879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.73048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-01-29T12:55:21.759895Z","caller":"traceutil/trace.go:171","msg":"trace[360311139] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:872; }","duration":"182.779961ms","start":"2026-01-29T12:55:21.57711Z","end":"2026-01-29T12:55:21.75989Z","steps":["trace[360311139] 'agreement among raft nodes before linearized reading' (duration: 182.704119ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:21.759895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.149998ms","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-01-29T12:55:21.759964Z","caller":"traceutil/trace.go:171","msg":"trace[414800956] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:872; }","duration":"205.27217ms","start":"2026-01-29T12:55:21.554675Z","end":"2026-01-29T12:55:21.759947Z","steps":["trace[414800956] 'agreement among raft nodes before linearized reading' (duration: 205.041995ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:24.711256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.152727666s","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-01-29T12:55:24.711405Z","caller":"traceutil/trace.go:171","msg":"trace[610662207] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:876; }","duration":"1.152898161s","start":"2026-01-29T12:55:23.558481Z","end":"2026-01-29T12:55:24.711379Z","steps":["trace[610662207] 'count revisions from in-memory index tree' (duration: 1.152654085s)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:24.711475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:23.558437Z","time spent":"1.153020104s","remote":"127.0.0.1:47424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-01-29T12:55:24.711817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.120273958s","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":"info","ts":"2026-01-29T12:55:24.711886Z","caller":"traceutil/trace.go:171","msg":"trace[520995467] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:876; }","duration":"1.120365471s","start":"2026-01-29T12:55:23.591504Z","end":"2026-01-29T12:55:24.711869Z","steps":["trace[520995467] 'count revisions from in-memory index tree' (duration: 1.120196027s)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:24.711948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:23.591496Z","time spent":"1.120433902s","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":7,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-01-29T12:55:24.71245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"949.203349ms","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-01-29T12:55:24.712504Z","caller":"traceutil/trace.go:171","msg":"trace[1627806104] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:876; }","duration":"949.290312ms","start":"2026-01-29T12:55:23.7632Z","end":"2026-01-29T12:55:24.71249Z","steps":["trace[1627806104] 'range keys from in-memory index tree' (duration: 949.003594ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:24.712541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:23.763182Z","time spent":"949.351404ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-01-29T12:55:24.712754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"880.002326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-01-29T12:55:24.712791Z","caller":"traceutil/trace.go:171","msg":"trace[537829280] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:876; }","duration":"880.073958ms","start":"2026-01-29T12:55:23.832707Z","end":"2026-01-29T12:55:24.712781Z","steps":["trace[537829280] 'range keys from in-memory index tree' (duration: 879.889244ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:24.712827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:23.832689Z","time spent":"880.13002ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-01-29T12:55:24.713064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"878.976252ms","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-01-29T12:55:24.713106Z","caller":"traceutil/trace.go:171","msg":"trace[1359940683] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:876; }","duration":"879.063344ms","start":"2026-01-29T12:55:23.834032Z","end":"2026-01-29T12:55:24.713096Z","steps":["trace[1359940683] 'range keys from in-memory index tree' (duration: 878.881199ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:24.713141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:23.834021Z","time spent":"879.112775ms","remote":"127.0.0.1:47240","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-01-29T12:55:24.713382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"861.340642ms","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-01-29T12:55:24.713495Z","caller":"traceutil/trace.go:171","msg":"trace[2116206090] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:876; }","duration":"861.460595ms","start":"2026-01-29T12:55:23.852023Z","end":"2026-01-29T12:55:24.713484Z","steps":["trace[2116206090] 'range keys from in-memory index tree' (duration: 861.329522ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:24.713793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.264265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-01-29T12:55:24.713836Z","caller":"traceutil/trace.go:171","msg":"trace[1719883535] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:876; }","duration":"631.330947ms","start":"2026-01-29T12:55:24.082494Z","end":"2026-01-29T12:55:24.713825Z","steps":["trace[1719883535] 'range keys from in-memory index tree' (duration: 631.171293ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:24.713874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:24.082467Z","time spent":"631.397088ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-01-29T12:55:25.040968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.443055ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-01-29T12:55:25.041138Z","caller":"traceutil/trace.go:171","msg":"trace[431756303] linearizableReadLoop","detail":"{readStateIndex:914; appliedIndex:911; }","duration":"131.80394ms","start":"2026-01-29T12:55:24.909321Z","end":"2026-01-29T12:55:25.041125Z","steps":["trace[431756303] 'read index received' (duration: 37.881µs)","trace[431756303] 'applied index is now lower than readState.Index' (duration: 131.765339ms)"],"step_count":2} {"level":"info","ts":"2026-01-29T12:55:25.041224Z","caller":"traceutil/trace.go:171","msg":"trace[1189955587] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"319.474352ms","start":"2026-01-29T12:55:24.72173Z","end":"2026-01-29T12:55:25.041204Z","steps":["trace[1189955587] 'process raft request' (duration: 319.367749ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:25.041341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:24.721719Z","time spent":"319.566165ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-01-29T12:55:25.041355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.031745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.74\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-01-29T12:55:25.041378Z","caller":"traceutil/trace.go:171","msg":"trace[714106896] range","detail":"{range_begin:/registry/masterleases/162.253.55.74; range_end:; response_count:1; response_revision:880; }","duration":"132.090347ms","start":"2026-01-29T12:55:24.90928Z","end":"2026-01-29T12:55:25.041371Z","steps":["trace[714106896] 'agreement among raft nodes before linearized reading' (duration: 132.010335ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:55:25.041471Z","caller":"traceutil/trace.go:171","msg":"trace[1002791446] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"321.133694ms","start":"2026-01-29T12:55:24.720327Z","end":"2026-01-29T12:55:25.041461Z","steps":["trace[1002791446] 'process raft request' (duration: 129.122655ms)","trace[1002791446] 'compare' (duration: 191.293361ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:55:25.041512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:24.720311Z","time spent":"321.173164ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-29T12:55:25.041584Z","caller":"traceutil/trace.go:171","msg":"trace[467095882] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"321.037981ms","start":"2026-01-29T12:55:24.72054Z","end":"2026-01-29T12:55:25.041578Z","steps":["trace[467095882] 'process raft request' (duration: 320.499788ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:25.041614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:24.720527Z","time spent":"321.068833ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-01-29T12:55:25.420581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.055268ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-01-29T12:55:25.420642Z","caller":"traceutil/trace.go:171","msg":"trace[123401568] linearizableReadLoop","detail":"{readStateIndex:915; appliedIndex:914; }","duration":"158.737203ms","start":"2026-01-29T12:55:25.261895Z","end":"2026-01-29T12:55:25.420632Z","steps":["trace[123401568] 'read index received' (duration: 23.891µs)","trace[123401568] 'applied index is now lower than readState.Index' (duration: 158.712461ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:55:25.420693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:25.04332Z","time spent":"377.371255ms","remote":"127.0.0.1:46988","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-01-29T12:55:25.420807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.907517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-29T12:55:25.420821Z","caller":"traceutil/trace.go:171","msg":"trace[337149468] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:880; }","duration":"158.949577ms","start":"2026-01-29T12:55:25.261866Z","end":"2026-01-29T12:55:25.420816Z","steps":["trace[337149468] 'agreement among raft nodes before linearized reading' (duration: 158.917106ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:25.420909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.672695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-29T12:55:25.420928Z","caller":"traceutil/trace.go:171","msg":"trace[2072630810] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:880; }","duration":"112.715955ms","start":"2026-01-29T12:55:25.308207Z","end":"2026-01-29T12:55:25.420923Z","steps":["trace[2072630810] 'agreement among raft nodes before linearized reading' (duration: 112.688714ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:55:29.071358Z","caller":"traceutil/trace.go:171","msg":"trace[676904171] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"265.123199ms","start":"2026-01-29T12:55:28.806221Z","end":"2026-01-29T12:55:29.071344Z","steps":["trace[676904171] 'process raft request' (duration: 264.988326ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:55:29.20008Z","caller":"traceutil/trace.go:171","msg":"trace[204251793] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"120.288324ms","start":"2026-01-29T12:55:29.079774Z","end":"2026-01-29T12:55:29.200062Z","steps":["trace[204251793] 'process raft request' (duration: 110.427069ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:55:29.200582Z","caller":"traceutil/trace.go:171","msg":"trace[1518437115] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"116.90517ms","start":"2026-01-29T12:55:29.08367Z","end":"2026-01-29T12:55:29.200575Z","steps":["trace[1518437115] 'process raft request' (duration: 116.746266ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:55:29.200641Z","caller":"traceutil/trace.go:171","msg":"trace[729961428] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"115.132456ms","start":"2026-01-29T12:55:29.085504Z","end":"2026-01-29T12:55:29.200637Z","steps":["trace[729961428] 'process raft request' (duration: 114.938301ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:29.812406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.062609ms","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-01-29T12:55:29.812458Z","caller":"traceutil/trace.go:171","msg":"trace[846742744] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:893; }","duration":"310.143292ms","start":"2026-01-29T12:55:29.502305Z","end":"2026-01-29T12:55:29.812448Z","steps":["trace[846742744] 'range keys from in-memory index tree' (duration: 309.969508ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:29.812479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:29.502293Z","time spent":"310.181642ms","remote":"127.0.0.1:47240","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-01-29T12:55:37.472441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.86115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-01-29T12:55:37.472493Z","caller":"traceutil/trace.go:171","msg":"trace[191581739] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:912; }","duration":"243.958192ms","start":"2026-01-29T12:55:37.228522Z","end":"2026-01-29T12:55:37.47248Z","steps":["trace[191581739] 'range keys from in-memory index tree' (duration: 243.734547ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:37.472606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.212555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-01-29T12:55:37.472648Z","caller":"traceutil/trace.go:171","msg":"trace[801582336] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:912; }","duration":"239.274776ms","start":"2026-01-29T12:55:37.233362Z","end":"2026-01-29T12:55:37.472637Z","steps":["trace[801582336] 'range keys from in-memory index tree' (duration: 239.111572ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:37.472706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.108624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-29T12:55:37.472716Z","caller":"traceutil/trace.go:171","msg":"trace[2098910947] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:912; }","duration":"223.141645ms","start":"2026-01-29T12:55:37.249571Z","end":"2026-01-29T12:55:37.472713Z","steps":["trace[2098910947] 'range keys from in-memory index tree' (duration: 223.064813ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:37.472871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.761693ms","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-01-29T12:55:37.472895Z","caller":"traceutil/trace.go:171","msg":"trace[1317303781] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:912; }","duration":"246.819764ms","start":"2026-01-29T12:55:37.226069Z","end":"2026-01-29T12:55:37.472889Z","steps":["trace[1317303781] 'range keys from in-memory index tree' (duration: 246.661411ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:55:37.819672Z","caller":"traceutil/trace.go:171","msg":"trace[1791952213] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"341.675285ms","start":"2026-01-29T12:55:37.477974Z","end":"2026-01-29T12:55:37.819649Z","steps":["trace[1791952213] 'process raft request' (duration: 341.581883ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:55:37.819748Z","caller":"traceutil/trace.go:171","msg":"trace[1688629181] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"342.197678ms","start":"2026-01-29T12:55:37.477514Z","end":"2026-01-29T12:55:37.819712Z","steps":["trace[1688629181] 'process raft request' (duration: 298.023028ms)","trace[1688629181] 'compare' (duration: 43.719089ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:55:37.819802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:37.477966Z","time spent":"341.769567ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-01-29T12:55:37.819946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:37.477506Z","time spent":"342.320671ms","remote":"127.0.0.1:47240","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-01-29T12:55:38.409691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.80909ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-01-29T12:55:38.409795Z","caller":"traceutil/trace.go:171","msg":"trace[1579413711] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"550.120635ms","start":"2026-01-29T12:55:37.859655Z","end":"2026-01-29T12:55:38.409776Z","steps":["trace[1579413711] 'process raft request' (duration: 228.15207ms)","trace[1579413711] 'compare' (duration: 321.200325ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:55:38.40989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:37.859642Z","time spent":"550.215688ms","remote":"127.0.0.1:47240","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-01-29T12:55:39.385346Z","caller":"traceutil/trace.go:171","msg":"trace[1248822167] linearizableReadLoop","detail":"{readStateIndex:954; appliedIndex:953; }","duration":"137.643346ms","start":"2026-01-29T12:55:39.247686Z","end":"2026-01-29T12:55:39.385329Z","steps":["trace[1248822167] 'read index received' (duration: 137.496303ms)","trace[1248822167] 'applied index is now lower than readState.Index' (duration: 146.403µs)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:55:39.385513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.7945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-29T12:55:39.38554Z","caller":"traceutil/trace.go:171","msg":"trace[304329691] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:917; }","duration":"137.876052ms","start":"2026-01-29T12:55:39.247656Z","end":"2026-01-29T12:55:39.385532Z","steps":["trace[304329691] 'agreement among raft nodes before linearized reading' (duration: 137.747009ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:55:39.385839Z","caller":"traceutil/trace.go:171","msg":"trace[1530861191] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"209.094705ms","start":"2026-01-29T12:55:39.176737Z","end":"2026-01-29T12:55:39.385831Z","steps":["trace[1530861191] 'process raft request' (duration: 208.50087ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:39.928239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.469493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-01-29T12:55:39.928297Z","caller":"traceutil/trace.go:171","msg":"trace[1231632646] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:917; }","duration":"399.566476ms","start":"2026-01-29T12:55:39.528717Z","end":"2026-01-29T12:55:39.928283Z","steps":["trace[1231632646] 'range keys from in-memory index tree' (duration: 399.355341ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:39.928323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:39.528702Z","time spent":"399.615557ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-01-29T12:55:39.928419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.348355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-01-29T12:55:39.92852Z","caller":"traceutil/trace.go:171","msg":"trace[1474808104] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:917; }","duration":"443.511859ms","start":"2026-01-29T12:55:39.484984Z","end":"2026-01-29T12:55:39.928495Z","steps":["trace[1474808104] 'count revisions from in-memory index tree' (duration: 443.275573ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:39.928574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:39.484966Z","time spent":"443.595612ms","remote":"127.0.0.1:47328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":30,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-01-29T12:55:39.928685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.087929ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-01-29T12:55:39.928734Z","caller":"traceutil/trace.go:171","msg":"trace[565523842] linearizableReadLoop","detail":"{readStateIndex:955; appliedIndex:954; }","duration":"104.482481ms","start":"2026-01-29T12:55:39.82424Z","end":"2026-01-29T12:55:39.928722Z","steps":["trace[565523842] 'read index received' (duration: 26.99µs)","trace[565523842] 'applied index is now lower than readState.Index' (duration: 104.454911ms)"],"step_count":2} {"level":"info","ts":"2026-01-29T12:55:39.928869Z","caller":"traceutil/trace.go:171","msg":"trace[602907208] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"373.873296ms","start":"2026-01-29T12:55:39.554987Z","end":"2026-01-29T12:55:39.928861Z","steps":["trace[602907208] 'process raft request' (duration: 202.547331ms)","trace[602907208] 'compare' (duration: 170.495434ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:55:39.928909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:39.554968Z","time spent":"373.918627ms","remote":"127.0.0.1:47240","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-01-29T12:55:39.929139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.019949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-01-29T12:55:39.929167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.922892ms","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-01-29T12:55:39.929178Z","caller":"traceutil/trace.go:171","msg":"trace[65068973] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:918; }","duration":"104.079031ms","start":"2026-01-29T12:55:39.825088Z","end":"2026-01-29T12:55:39.929167Z","steps":["trace[65068973] 'agreement among raft nodes before linearized reading' (duration: 103.859296ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:55:39.929192Z","caller":"traceutil/trace.go:171","msg":"trace[1159970523] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:918; }","duration":"104.974924ms","start":"2026-01-29T12:55:39.824209Z","end":"2026-01-29T12:55:39.929184Z","steps":["trace[1159970523] 'agreement among raft nodes before linearized reading' (duration: 104.898752ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:40.72262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.731382ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-01-29T12:55:40.722712Z","caller":"traceutil/trace.go:171","msg":"trace[1143947883] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"784.937299ms","start":"2026-01-29T12:55:39.937758Z","end":"2026-01-29T12:55:40.722695Z","steps":["trace[1143947883] 'process raft request' (duration: 258.057244ms)","trace[1143947883] 'compare' (duration: 526.368523ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:55:40.72279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:39.93775Z","time spent":"784.99048ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-29T12:55:40.741729Z","caller":"traceutil/trace.go:171","msg":"trace[2102508450] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"803.316617ms","start":"2026-01-29T12:55:39.938394Z","end":"2026-01-29T12:55:40.74171Z","steps":["trace[2102508450] 'process raft request' (duration: 803.280826ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:40.741863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:39.938388Z","time spent":"803.397039ms","remote":"127.0.0.1:47240","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-01-29T12:55:40.742171Z","caller":"traceutil/trace.go:171","msg":"trace[1580286420] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"804.62814ms","start":"2026-01-29T12:55:39.937532Z","end":"2026-01-29T12:55:40.74216Z","steps":["trace[1580286420] 'process raft request' (duration: 804.007584ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:40.742212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:39.937514Z","time spent":"804.67484ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-29T12:55:40.743997Z","caller":"traceutil/trace.go:171","msg":"trace[449911656] linearizableReadLoop","detail":"{readStateIndex:958; appliedIndex:958; }","duration":"478.283926ms","start":"2026-01-29T12:55:40.265701Z","end":"2026-01-29T12:55:40.743985Z","steps":["trace[449911656] 'read index received' (duration: 478.279826ms)","trace[449911656] 'applied index is now lower than readState.Index' (duration: 3.26µs)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:55:40.744066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.373818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-29T12:55:40.744087Z","caller":"traceutil/trace.go:171","msg":"trace[331114827] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:921; }","duration":"478.436409ms","start":"2026-01-29T12:55:40.265644Z","end":"2026-01-29T12:55:40.74408Z","steps":["trace[331114827] 'agreement among raft nodes before linearized reading' (duration: 478.398278ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:40.744106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:40.265621Z","time spent":"478.481101ms","remote":"127.0.0.1:46958","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-01-29T12:55:41.631753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.156385ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-01-29T12:55:41.631862Z","caller":"traceutil/trace.go:171","msg":"trace[1752615630] linearizableReadLoop","detail":"{readStateIndex:959; appliedIndex:958; }","duration":"887.825089ms","start":"2026-01-29T12:55:40.744019Z","end":"2026-01-29T12:55:41.631844Z","steps":["trace[1752615630] 'read index received' (duration: 145.46799ms)","trace[1752615630] 'applied index is now lower than readState.Index' (duration: 742.355579ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:55:41.632095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.216498452s","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-01-29T12:55:41.632134Z","caller":"traceutil/trace.go:171","msg":"trace[1420504839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:921; }","duration":"1.216578855s","start":"2026-01-29T12:55:40.415545Z","end":"2026-01-29T12:55:41.632124Z","steps":["trace[1420504839] 'agreement among raft nodes before linearized reading' (duration: 1.216429451s)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:41.632166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:40.415527Z","time spent":"1.216631395s","remote":"127.0.0.1:47240","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-01-29T12:55:41.632821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"887.705917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-29T12:55:41.632855Z","caller":"traceutil/trace.go:171","msg":"trace[275243891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:921; }","duration":"887.776109ms","start":"2026-01-29T12:55:40.74507Z","end":"2026-01-29T12:55:41.632846Z","steps":["trace[275243891] 'agreement among raft nodes before linearized reading' (duration: 887.693947ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:41.632883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:40.745057Z","time spent":"887.82053ms","remote":"127.0.0.1:46964","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-01-29T12:55:41.633053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.311795ms","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-01-29T12:55:41.633117Z","caller":"traceutil/trace.go:171","msg":"trace[495417408] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:921; }","duration":"218.394407ms","start":"2026-01-29T12:55:41.414687Z","end":"2026-01-29T12:55:41.633082Z","steps":["trace[495417408] 'agreement among raft nodes before linearized reading' (duration: 218.333195ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:41.633193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.371474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-01-29T12:55:41.633268Z","caller":"traceutil/trace.go:171","msg":"trace[430188797] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:921; }","duration":"833.514128ms","start":"2026-01-29T12:55:40.799735Z","end":"2026-01-29T12:55:41.633249Z","steps":["trace[430188797] 'agreement among raft nodes before linearized reading' (duration: 833.358884ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:41.633314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:40.799716Z","time spent":"833.586809ms","remote":"127.0.0.1:43324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":3,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-01-29T12:55:41.633537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.391174ms","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-01-29T12:55:41.633571Z","caller":"traceutil/trace.go:171","msg":"trace[1937792190] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:921; }","duration":"244.461626ms","start":"2026-01-29T12:55:41.389099Z","end":"2026-01-29T12:55:41.633561Z","steps":["trace[1937792190] 'agreement among raft nodes before linearized reading' (duration: 244.360933ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:42.122451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.028438ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-01-29T12:55:42.122539Z","caller":"traceutil/trace.go:171","msg":"trace[1648368044] linearizableReadLoop","detail":"{readStateIndex:961; appliedIndex:959; }","duration":"475.869706ms","start":"2026-01-29T12:55:41.646654Z","end":"2026-01-29T12:55:42.122523Z","steps":["trace[1648368044] 'read index received' (duration: 37.785572ms)","trace[1648368044] 'applied index is now lower than readState.Index' (duration: 438.082593ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:55:42.122617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.959068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-29T12:55:42.122642Z","caller":"traceutil/trace.go:171","msg":"trace[1663315779] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:923; }","duration":"475.998128ms","start":"2026-01-29T12:55:41.646635Z","end":"2026-01-29T12:55:42.122633Z","steps":["trace[1663315779] 'agreement among raft nodes before linearized reading' (duration: 475.929977ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:42.122673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:41.646628Z","time spent":"476.037159ms","remote":"127.0.0.1:46958","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-01-29T12:55:42.122718Z","caller":"traceutil/trace.go:171","msg":"trace[855057830] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"480.613753ms","start":"2026-01-29T12:55:41.642082Z","end":"2026-01-29T12:55:42.122696Z","steps":["trace[855057830] 'process raft request' (duration: 137.267017ms)","trace[855057830] 'compare' (duration: 342.6924ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:55:42.122829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:41.642074Z","time spent":"480.690415ms","remote":"127.0.0.1:47240","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-01-29T12:55:44.260709Z","caller":"traceutil/trace.go:171","msg":"trace[2059454256] linearizableReadLoop","detail":"{readStateIndex:965; appliedIndex:964; }","duration":"133.580306ms","start":"2026-01-29T12:55:44.127112Z","end":"2026-01-29T12:55:44.260693Z","steps":["trace[2059454256] 'read index received' (duration: 133.453873ms)","trace[2059454256] 'applied index is now lower than readState.Index' (duration: 125.913µs)"],"step_count":2} {"level":"info","ts":"2026-01-29T12:55:44.260778Z","caller":"traceutil/trace.go:171","msg":"trace[1219658392] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"567.040296ms","start":"2026-01-29T12:55:43.693732Z","end":"2026-01-29T12:55:44.260773Z","steps":["trace[1219658392] 'process raft request' (duration: 566.876132ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:44.260854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:43.693721Z","time spent":"567.073498ms","remote":"127.0.0.1:47240","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-01-29T12:55:44.261102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.988936ms","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-01-29T12:55:44.261132Z","caller":"traceutil/trace.go:171","msg":"trace[1681454561] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:927; }","duration":"134.095299ms","start":"2026-01-29T12:55:44.127031Z","end":"2026-01-29T12:55:44.261127Z","steps":["trace[1681454561] 'agreement among raft nodes before linearized reading' (duration: 134.013587ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:55:44.502185Z","caller":"traceutil/trace.go:171","msg":"trace[408331298] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"236.953228ms","start":"2026-01-29T12:55:44.265203Z","end":"2026-01-29T12:55:44.502156Z","steps":["trace[408331298] 'process raft request' (duration: 213.393832ms)","trace[408331298] 'compare' (duration: 23.461524ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:55:44.914338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.865148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-01-29T12:55:44.914398Z","caller":"traceutil/trace.go:171","msg":"trace[281467502] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:928; }","duration":"134.95531ms","start":"2026-01-29T12:55:44.779428Z","end":"2026-01-29T12:55:44.914383Z","steps":["trace[281467502] 'range keys from in-memory index tree' (duration: 134.747915ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:44.914447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.049302ms","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-01-29T12:55:44.914503Z","caller":"traceutil/trace.go:171","msg":"trace[19097825] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:928; }","duration":"135.113024ms","start":"2026-01-29T12:55:44.779379Z","end":"2026-01-29T12:55:44.914492Z","steps":["trace[19097825] 'range keys from in-memory index tree' (duration: 134.910618ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:44.914818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.633466ms","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-01-29T12:55:44.914842Z","caller":"traceutil/trace.go:171","msg":"trace[745787690] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:928; }","duration":"151.692976ms","start":"2026-01-29T12:55:44.763142Z","end":"2026-01-29T12:55:44.914835Z","steps":["trace[745787690] 'range keys from in-memory index tree' (duration: 151.549983ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:55:46.666979Z","caller":"traceutil/trace.go:171","msg":"trace[1907902843] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"399.100776ms","start":"2026-01-29T12:55:46.267856Z","end":"2026-01-29T12:55:46.666957Z","steps":["trace[1907902843] 'process raft request' (duration: 398.953022ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:46.667189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:46.267845Z","time spent":"399.26164ms","remote":"127.0.0.1:47240","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-01-29T12:55:46.849295Z","caller":"traceutil/trace.go:171","msg":"trace[857433407] linearizableReadLoop","detail":"{readStateIndex:981; appliedIndex:980; }","duration":"342.751353ms","start":"2026-01-29T12:55:46.506521Z","end":"2026-01-29T12:55:46.849272Z","steps":["trace[857433407] 'read index received' (duration: 160.62506ms)","trace[857433407] 'applied index is now lower than readState.Index' (duration: 182.125233ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:55:46.849524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.983849ms","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-01-29T12:55:46.849563Z","caller":"traceutil/trace.go:171","msg":"trace[1283419358] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:942; }","duration":"343.060151ms","start":"2026-01-29T12:55:46.506491Z","end":"2026-01-29T12:55:46.849551Z","steps":["trace[1283419358] 'agreement among raft nodes before linearized reading' (duration: 342.860736ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:46.849597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:46.50648Z","time spent":"343.109052ms","remote":"127.0.0.1:47240","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":"info","ts":"2026-01-29T12:55:46.84989Z","caller":"traceutil/trace.go:171","msg":"trace[628472335] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"364.375972ms","start":"2026-01-29T12:55:46.4855Z","end":"2026-01-29T12:55:46.849876Z","steps":["trace[628472335] 'process raft request' (duration: 363.211302ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:46.849978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:55:46.485486Z","time spent":"364.431873ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-29T12:55:57.091055Z","caller":"traceutil/trace.go:171","msg":"trace[1803229204] linearizableReadLoop","detail":"{readStateIndex:1047; appliedIndex:1046; }","duration":"104.043181ms","start":"2026-01-29T12:55:56.986983Z","end":"2026-01-29T12:55:57.091026Z","steps":["trace[1803229204] 'read index received' (duration: 103.856106ms)","trace[1803229204] 'applied index is now lower than readState.Index' (duration: 185.795µs)"],"step_count":2} {"level":"info","ts":"2026-01-29T12:55:57.091232Z","caller":"traceutil/trace.go:171","msg":"trace[129508785] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"113.751482ms","start":"2026-01-29T12:55:56.977462Z","end":"2026-01-29T12:55:57.091214Z","steps":["trace[129508785] 'process raft request' (duration: 113.400343ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:57.091486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.136009ms","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-01-29T12:55:57.091537Z","caller":"traceutil/trace.go:171","msg":"trace[516441028] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1006; }","duration":"103.21175ms","start":"2026-01-29T12:55:56.988315Z","end":"2026-01-29T12:55:57.091527Z","steps":["trace[516441028] 'agreement among raft nodes before linearized reading' (duration: 103.009825ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:55:57.091657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.667945ms","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-01-29T12:55:57.091707Z","caller":"traceutil/trace.go:171","msg":"trace[242651187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1006; }","duration":"104.737847ms","start":"2026-01-29T12:55:56.986959Z","end":"2026-01-29T12:55:57.091696Z","steps":["trace[242651187] 'agreement among raft nodes before linearized reading' (duration: 104.633384ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:56:01.494943Z","caller":"traceutil/trace.go:171","msg":"trace[1834145233] linearizableReadLoop","detail":"{readStateIndex:1085; appliedIndex:1083; }","duration":"243.933453ms","start":"2026-01-29T12:56:01.250987Z","end":"2026-01-29T12:56:01.49492Z","steps":["trace[1834145233] 'read index received' (duration: 176.410982ms)","trace[1834145233] 'applied index is now lower than readState.Index' (duration: 67.52156ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:56:01.495348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.077156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-01-29T12:56:01.495399Z","caller":"traceutil/trace.go:171","msg":"trace[337831442] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1043; }","duration":"244.436184ms","start":"2026-01-29T12:56:01.250949Z","end":"2026-01-29T12:56:01.495385Z","steps":["trace[337831442] 'agreement among raft nodes before linearized reading' (duration: 244.073226ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:56:01.495931Z","caller":"traceutil/trace.go:171","msg":"trace[2061279713] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"378.681037ms","start":"2026-01-29T12:56:01.117233Z","end":"2026-01-29T12:56:01.495914Z","steps":["trace[2061279713] 'process raft request' (duration: 310.157361ms)","trace[2061279713] 'compare' (duration: 67.0778ms)"],"step_count":2} {"level":"warn","ts":"2026-01-29T12:56:01.496022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:56:01.117226Z","time spent":"378.743138ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-01-29T12:56:01.496152Z","caller":"traceutil/trace.go:171","msg":"trace[490541161] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"378.344888ms","start":"2026-01-29T12:56:01.117796Z","end":"2026-01-29T12:56:01.496141Z","steps":["trace[490541161] 'process raft request' (duration: 377.075327ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:56:01.496201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:56:01.117791Z","time spent":"378.38159ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-01-29T12:56:02.07094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.883262ms","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:533"} {"level":"info","ts":"2026-01-29T12:56:02.071016Z","caller":"traceutil/trace.go:171","msg":"trace[472264105] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1043; }","duration":"138.004096ms","start":"2026-01-29T12:56:01.932994Z","end":"2026-01-29T12:56:02.070998Z","steps":["trace[472264105] 'range keys from in-memory index tree' (duration: 137.737359ms)"],"step_count":1} {"level":"info","ts":"2026-01-29T12:59:06.003959Z","caller":"traceutil/trace.go:171","msg":"trace[1919580837] linearizableReadLoop","detail":"{readStateIndex:1904; appliedIndex:1903; }","duration":"300.050012ms","start":"2026-01-29T12:59:05.703878Z","end":"2026-01-29T12:59:06.003928Z","steps":["trace[1919580837] 'read index received' (duration: 297.982551ms)","trace[1919580837] 'applied index is now lower than readState.Index' (duration: 2.066281ms)"],"step_count":2} {"level":"info","ts":"2026-01-29T12:59:06.004664Z","caller":"traceutil/trace.go:171","msg":"trace[184915014] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"324.82002ms","start":"2026-01-29T12:59:05.679832Z","end":"2026-01-29T12:59:06.004652Z","steps":["trace[184915014] 'process raft request' (duration: 322.114593ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:59:06.006052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:59:05.679819Z","time spent":"326.131971ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-01-29T12:59:06.006373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.891792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-01-29T12:59:06.00656Z","caller":"traceutil/trace.go:171","msg":"trace[635940879] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1824; }","duration":"259.082996ms","start":"2026-01-29T12:59:05.747464Z","end":"2026-01-29T12:59:06.006547Z","steps":["trace[635940879] 'agreement among raft nodes before linearized reading' (duration: 258.85441ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:59:06.004825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.917563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-01-29T12:59:06.006887Z","caller":"traceutil/trace.go:171","msg":"trace[138480583] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1824; }","duration":"302.969633ms","start":"2026-01-29T12:59:05.703862Z","end":"2026-01-29T12:59:06.006832Z","steps":["trace[138480583] 'agreement among raft nodes before linearized reading' (duration: 300.829531ms)"],"step_count":1} {"level":"warn","ts":"2026-01-29T12:59:06.007052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-01-29T12:59:05.703848Z","time spent":"303.124738ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-01-29T12:59:06.007566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.811643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-01-29T12:59:06.011364Z","caller":"traceutil/trace.go:171","msg":"trace[764524129] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1824; }","duration":"192.623717ms","start":"2026-01-29T12:59:05.818726Z","end":"2026-01-29T12:59:06.01135Z","steps":["trace[764524129] 'agreement among raft nodes before linearized reading' (duration: 188.785793ms)"],"step_count":1}