{"level":"warn","ts":"2026-02-26T21:38:18.11018Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-26T21:38:18.110291Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.227: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.227:2380","--initial-cluster=instance=https://162.253.55.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.227: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-02-26T21:38:18.110384Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-26T21:38:18.110414Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.227:2380"]} {"level":"info","ts":"2026-02-26T21:38:18.110443Z","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-02-26T21:38:18.111088Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.227:2379"]} {"level":"info","ts":"2026-02-26T21:38:18.111186Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.227:2380"],"listen-peer-urls":["https://162.253.55.227:2380"],"advertise-client-urls":["https://162.253.55.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.227: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-02-26T21:38:18.116166Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.733262ms"} {"level":"info","ts":"2026-02-26T21:38:18.121819Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9bd37ed2859641e3","cluster-id":"47d0f4f0a1c3b0a9"} {"level":"info","ts":"2026-02-26T21:38:18.121906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 switched to configuration voters=()"} {"level":"info","ts":"2026-02-26T21:38:18.123176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became follower at term 0"} {"level":"info","ts":"2026-02-26T21:38:18.123211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9bd37ed2859641e3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-26T21:38:18.123261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became follower at term 1"} {"level":"info","ts":"2026-02-26T21:38:18.123348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 switched to configuration voters=(11228457738614227427)"} {"level":"warn","ts":"2026-02-26T21:38:18.129527Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-26T21:38:18.131182Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-26T21:38:18.134028Z","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-02-26T21:38:18.139092Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9bd37ed2859641e3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-26T21:38:18.139272Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9bd37ed2859641e3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-26T21:38:18.139341Z","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-02-26T21:38:18.140046Z","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-02-26T21:38:18.140074Z","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-02-26T21:38:18.14099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 switched to configuration voters=(11228457738614227427)"} {"level":"info","ts":"2026-02-26T21:38:18.141197Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"47d0f4f0a1c3b0a9","local-member-id":"9bd37ed2859641e3","added-peer-id":"9bd37ed2859641e3","added-peer-peer-urls":["https://162.253.55.227:2380"]} {"level":"info","ts":"2026-02-26T21:38:18.144811Z","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-02-26T21:38:18.144917Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.227:2380"} {"level":"info","ts":"2026-02-26T21:38:18.144962Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.227:2380"} {"level":"info","ts":"2026-02-26T21:38:18.145267Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9bd37ed2859641e3","initial-advertise-peer-urls":["https://162.253.55.227:2380"],"listen-peer-urls":["https://162.253.55.227:2380"],"advertise-client-urls":["https://162.253.55.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-26T21:38:18.145357Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-26T21:38:18.424383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 is starting a new election at term 1"} {"level":"info","ts":"2026-02-26T21:38:18.424464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-26T21:38:18.424489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 received MsgPreVoteResp from 9bd37ed2859641e3 at term 1"} {"level":"info","ts":"2026-02-26T21:38:18.424509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became candidate at term 2"} {"level":"info","ts":"2026-02-26T21:38:18.424524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 received MsgVoteResp from 9bd37ed2859641e3 at term 2"} {"level":"info","ts":"2026-02-26T21:38:18.424544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9bd37ed2859641e3 became leader at term 2"} {"level":"info","ts":"2026-02-26T21:38:18.424563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9bd37ed2859641e3 elected leader 9bd37ed2859641e3 at term 2"} {"level":"info","ts":"2026-02-26T21:38:18.425495Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T21:38:18.426656Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9bd37ed2859641e3","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.227:2379]}","request-path":"/0/members/9bd37ed2859641e3/attributes","cluster-id":"47d0f4f0a1c3b0a9","publish-timeout":"7s"} {"level":"info","ts":"2026-02-26T21:38:18.42679Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T21:38:18.426948Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"47d0f4f0a1c3b0a9","local-member-id":"9bd37ed2859641e3","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T21:38:18.427061Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T21:38:18.427107Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T21:38:18.429482Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-26T21:38:18.42956Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T21:38:18.430805Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-26T21:38:18.430843Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-26T21:38:18.436591Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.227:2379"} {"level":"warn","ts":"2026-02-26T21:38:26.706673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.499032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"} {"level":"warn","ts":"2026-02-26T21:38:26.706736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.997751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-26T21:38:26.706811Z","caller":"traceutil/trace.go:171","msg":"trace[1356092833] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:337; }","duration":"108.694816ms","start":"2026-02-26T21:38:26.598094Z","end":"2026-02-26T21:38:26.706788Z","steps":["trace[1356092833] 'range keys from in-memory index tree' (duration: 108.335468ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:38:26.706822Z","caller":"traceutil/trace.go:171","msg":"trace[527151192] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:337; }","duration":"228.140204ms","start":"2026-02-26T21:38:26.478664Z","end":"2026-02-26T21:38:26.706804Z","steps":["trace[527151192] 'range keys from in-memory index tree' (duration: 227.898379ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:26.706862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.278657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:535"} {"level":"warn","ts":"2026-02-26T21:38:26.706985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.036732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"warn","ts":"2026-02-26T21:38:26.706862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.619613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"warn","ts":"2026-02-26T21:38:26.707104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.763837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7303"} {"level":"info","ts":"2026-02-26T21:38:26.707104Z","caller":"traceutil/trace.go:171","msg":"trace[657000878] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:337; }","duration":"108.180765ms","start":"2026-02-26T21:38:26.598895Z","end":"2026-02-26T21:38:26.707076Z","steps":["trace[657000878] 'range keys from in-memory index tree' (duration: 107.94465ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:26.707036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.183087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"warn","ts":"2026-02-26T21:38:26.707196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.915191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-26T21:38:26.707231Z","caller":"traceutil/trace.go:171","msg":"trace[6072712] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:337; }","duration":"178.971983ms","start":"2026-02-26T21:38:26.528252Z","end":"2026-02-26T21:38:26.707224Z","steps":["trace[6072712] 'range keys from in-memory index tree' (duration: 178.86386ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:38:26.707284Z","caller":"traceutil/trace.go:171","msg":"trace[1165360198] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:337; }","duration":"128.409022ms","start":"2026-02-26T21:38:26.578795Z","end":"2026-02-26T21:38:26.707204Z","steps":["trace[1165360198] 'range keys from in-memory index tree' (duration: 128.089595ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:26.707318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.85724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4664"} {"level":"info","ts":"2026-02-26T21:38:26.707425Z","caller":"traceutil/trace.go:171","msg":"trace[81123511] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:337; }","duration":"109.025643ms","start":"2026-02-26T21:38:26.598382Z","end":"2026-02-26T21:38:26.707408Z","steps":["trace[81123511] 'range keys from in-memory index tree' (duration: 108.757997ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:38:26.707033Z","caller":"traceutil/trace.go:171","msg":"trace[210654165] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:337; }","duration":"108.42206ms","start":"2026-02-26T21:38:26.59853Z","end":"2026-02-26T21:38:26.706952Z","steps":["trace[210654165] 'range keys from in-memory index tree' (duration: 108.199816ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:38:26.707154Z","caller":"traceutil/trace.go:171","msg":"trace[1026174730] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:337; }","duration":"108.803608ms","start":"2026-02-26T21:38:26.598334Z","end":"2026-02-26T21:38:26.707138Z","steps":["trace[1026174730] 'range keys from in-memory index tree' (duration: 108.651015ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:26.707647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.998591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-02-26T21:38:26.707691Z","caller":"traceutil/trace.go:171","msg":"trace[1195896549] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:337; }","duration":"329.086073ms","start":"2026-02-26T21:38:26.378595Z","end":"2026-02-26T21:38:26.707681Z","steps":["trace[1195896549] 'range keys from in-memory index tree' (duration: 328.030321ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:26.707063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.90352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-02-26T21:38:26.707749Z","caller":"traceutil/trace.go:171","msg":"trace[113569166] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:337; }","duration":"109.596706ms","start":"2026-02-26T21:38:26.598129Z","end":"2026-02-26T21:38:26.707726Z","steps":["trace[113569166] 'range keys from in-memory index tree' (duration: 108.784898ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:26.707763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:26.37857Z","time spent":"329.148655ms","remote":"127.0.0.1:60826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"info","ts":"2026-02-26T21:38:26.707147Z","caller":"traceutil/trace.go:171","msg":"trace[82887696] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:337; }","duration":"277.96154ms","start":"2026-02-26T21:38:26.429166Z","end":"2026-02-26T21:38:26.707128Z","steps":["trace[82887696] 'range keys from in-memory index tree' (duration: 277.51064ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:26.707038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.693846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4198"} {"level":"info","ts":"2026-02-26T21:38:26.708038Z","caller":"traceutil/trace.go:171","msg":"trace[981294016] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:337; }","duration":"109.703758ms","start":"2026-02-26T21:38:26.598294Z","end":"2026-02-26T21:38:26.707998Z","steps":["trace[981294016] 'range keys from in-memory index tree' (duration: 108.549493ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:38:26.906275Z","caller":"traceutil/trace.go:171","msg":"trace[1295055932] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"177.843539ms","start":"2026-02-26T21:38:26.728405Z","end":"2026-02-26T21:38:26.906248Z","steps":["trace[1295055932] 'process raft request' (duration: 92.563758ms)","trace[1295055932] 'compare' (duration: 85.115027ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:38:26.906561Z","caller":"traceutil/trace.go:171","msg":"trace[766500255] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"178.089424ms","start":"2026-02-26T21:38:26.728434Z","end":"2026-02-26T21:38:26.906524Z","steps":["trace[766500255] 'process raft request' (duration: 177.782947ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:38:26.906595Z","caller":"traceutil/trace.go:171","msg":"trace[526577516] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"178.120435ms","start":"2026-02-26T21:38:26.728456Z","end":"2026-02-26T21:38:26.906576Z","steps":["trace[526577516] 'process raft request' (duration: 177.941811ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:38:26.906584Z","caller":"traceutil/trace.go:171","msg":"trace[2036152030] linearizableReadLoop","detail":"{readStateIndex:352; appliedIndex:348; }","duration":"178.070204ms","start":"2026-02-26T21:38:26.728492Z","end":"2026-02-26T21:38:26.906562Z","steps":["trace[2036152030] 'read index received' (duration: 56.794396ms)","trace[2036152030] 'applied index is now lower than readState.Index' (duration: 121.274778ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:38:26.906714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.486928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4198"} {"level":"warn","ts":"2026-02-26T21:38:26.906811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.306725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-02-26T21:38:26.906854Z","caller":"traceutil/trace.go:171","msg":"trace[1604383995] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:342; }","duration":"176.377947ms","start":"2026-02-26T21:38:26.730463Z","end":"2026-02-26T21:38:26.906841Z","steps":["trace[1604383995] 'agreement among raft nodes before linearized reading' (duration: 176.293675ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:38:26.906843Z","caller":"traceutil/trace.go:171","msg":"trace[640851307] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:342; }","duration":"188.619991ms","start":"2026-02-26T21:38:26.718185Z","end":"2026-02-26T21:38:26.906805Z","steps":["trace[640851307] 'agreement among raft nodes before linearized reading' (duration: 188.446637ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:26.906981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.18655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4198"} {"level":"info","ts":"2026-02-26T21:38:26.907028Z","caller":"traceutil/trace.go:171","msg":"trace[499113855] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:342; }","duration":"187.253221ms","start":"2026-02-26T21:38:26.719764Z","end":"2026-02-26T21:38:26.907017Z","steps":["trace[499113855] 'agreement among raft nodes before linearized reading' (duration: 187.17454ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:26.907103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.87637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-02-26T21:38:26.907144Z","caller":"traceutil/trace.go:171","msg":"trace[655285910] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:342; }","duration":"127.918091ms","start":"2026-02-26T21:38:26.779215Z","end":"2026-02-26T21:38:26.907133Z","steps":["trace[655285910] 'agreement among raft nodes before linearized reading' (duration: 127.8583ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:26.907157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.882637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4198"} {"level":"info","ts":"2026-02-26T21:38:26.907195Z","caller":"traceutil/trace.go:171","msg":"trace[277042372] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:342; }","duration":"188.933888ms","start":"2026-02-26T21:38:26.718252Z","end":"2026-02-26T21:38:26.907186Z","steps":["trace[277042372] 'agreement among raft nodes before linearized reading' (duration: 188.871167ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:26.907238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.914173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4198"} {"level":"info","ts":"2026-02-26T21:38:26.907276Z","caller":"traceutil/trace.go:171","msg":"trace[1030209677] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:342; }","duration":"185.971924ms","start":"2026-02-26T21:38:26.721298Z","end":"2026-02-26T21:38:26.907269Z","steps":["trace[1030209677] 'agreement among raft nodes before linearized reading' (duration: 185.908202ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:26.907383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.142892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4198"} {"level":"info","ts":"2026-02-26T21:38:26.907422Z","caller":"traceutil/trace.go:171","msg":"trace[2067617904] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:342; }","duration":"189.194254ms","start":"2026-02-26T21:38:26.718219Z","end":"2026-02-26T21:38:26.907413Z","steps":["trace[2067617904] 'agreement among raft nodes before linearized reading' (duration: 189.130663ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:38:47.640956Z","caller":"traceutil/trace.go:171","msg":"trace[1494336388] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"167.495485ms","start":"2026-02-26T21:38:47.473435Z","end":"2026-02-26T21:38:47.64093Z","steps":["trace[1494336388] 'process raft request' (duration: 167.342352ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:38:48.405024Z","caller":"traceutil/trace.go:171","msg":"trace[373801067] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"153.676937ms","start":"2026-02-26T21:38:48.251318Z","end":"2026-02-26T21:38:48.404995Z","steps":["trace[373801067] 'process raft request' (duration: 153.555755ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:49.381958Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810625527844756,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T21:38:49.397128Z","caller":"traceutil/trace.go:171","msg":"trace[430648155] linearizableReadLoop","detail":"{readStateIndex:555; appliedIndex:554; }","duration":"515.236041ms","start":"2026-02-26T21:38:48.88187Z","end":"2026-02-26T21:38:49.397106Z","steps":["trace[430648155] 'read index received' (duration: 515.119659ms)","trace[430648155] 'applied index is now lower than readState.Index' (duration: 115.592µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:38:49.39723Z","caller":"traceutil/trace.go:171","msg":"trace[1594365226] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"545.991615ms","start":"2026-02-26T21:38:48.851217Z","end":"2026-02-26T21:38:49.397208Z","steps":["trace[1594365226] 'process raft request' (duration: 545.75849ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:49.397382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.507811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T21:38:49.397399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.298622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:38:49.397433Z","caller":"traceutil/trace.go:171","msg":"trace[1835141769] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:540; }","duration":"347.600773ms","start":"2026-02-26T21:38:49.049805Z","end":"2026-02-26T21:38:49.397406Z","steps":["trace[1835141769] 'agreement among raft nodes before linearized reading' (duration: 347.435799ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:49.397418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.522097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-26T21:38:49.397493Z","caller":"traceutil/trace.go:171","msg":"trace[1182331490] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:540; }","duration":"148.441344ms","start":"2026-02-26T21:38:49.249029Z","end":"2026-02-26T21:38:49.397471Z","steps":["trace[1182331490] 'agreement among raft nodes before linearized reading' (duration: 148.27407ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:38:49.397544Z","caller":"traceutil/trace.go:171","msg":"trace[1998538218] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:540; }","duration":"515.677211ms","start":"2026-02-26T21:38:48.881843Z","end":"2026-02-26T21:38:49.39752Z","steps":["trace[1998538218] 'agreement among raft nodes before linearized reading' (duration: 515.447806ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:49.397473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:49.049781Z","time spent":"347.685275ms","remote":"127.0.0.1:60720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-26T21:38:49.397646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:48.851179Z","time spent":"546.078407ms","remote":"127.0.0.1:60720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:38:49.397607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:48.881829Z","time spent":"515.764993ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T21:38:50.450672Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810625527844768,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T21:38:50.507708Z","caller":"traceutil/trace.go:171","msg":"trace[1102549858] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"635.646021ms","start":"2026-02-26T21:38:49.872041Z","end":"2026-02-26T21:38:50.507687Z","steps":["trace[1102549858] 'process raft request' (duration: 635.553079ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:38:50.507745Z","caller":"traceutil/trace.go:171","msg":"trace[271156383] linearizableReadLoop","detail":"{readStateIndex:559; appliedIndex:559; }","duration":"558.082626ms","start":"2026-02-26T21:38:49.949622Z","end":"2026-02-26T21:38:50.507705Z","steps":["trace[271156383] 'read index received' (duration: 558.065586ms)","trace[271156383] 'applied index is now lower than readState.Index' (duration: 14.52µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:38:50.507921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:49.872024Z","time spent":"635.729292ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:38:50.507965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.323201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T21:38:50.508062Z","caller":"traceutil/trace.go:171","msg":"trace[1365637654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:544; }","duration":"558.475835ms","start":"2026-02-26T21:38:49.949572Z","end":"2026-02-26T21:38:50.508048Z","steps":["trace[1365637654] 'agreement among raft nodes before linearized reading' (duration: 558.288721ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:50.508114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:49.949552Z","time spent":"558.549976ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-26T21:38:50.668685Z","caller":"traceutil/trace.go:171","msg":"trace[436140095] linearizableReadLoop","detail":"{readStateIndex:560; appliedIndex:559; }","duration":"160.831361ms","start":"2026-02-26T21:38:50.507831Z","end":"2026-02-26T21:38:50.668662Z","steps":["trace[436140095] 'read index received' (duration: 160.7794ms)","trace[436140095] 'applied index is now lower than readState.Index' (duration: 50.681µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:38:50.668826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.293221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-26T21:38:50.668838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.145426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-02-26T21:38:50.668842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.567026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"} {"level":"info","ts":"2026-02-26T21:38:50.668893Z","caller":"traceutil/trace.go:171","msg":"trace[484548143] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:545; }","duration":"230.389293ms","start":"2026-02-26T21:38:50.438486Z","end":"2026-02-26T21:38:50.668875Z","steps":["trace[484548143] 'agreement among raft nodes before linearized reading' (duration: 230.24019ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:38:50.668899Z","caller":"traceutil/trace.go:171","msg":"trace[2042905107] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:545; }","duration":"696.254429ms","start":"2026-02-26T21:38:49.972624Z","end":"2026-02-26T21:38:50.668879Z","steps":["trace[2042905107] 'agreement among raft nodes before linearized reading' (duration: 696.153357ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:50.668898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.599574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-02-26T21:38:50.66893Z","caller":"traceutil/trace.go:171","msg":"trace[1381872656] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:545; }","duration":"419.682368ms","start":"2026-02-26T21:38:50.249209Z","end":"2026-02-26T21:38:50.668892Z","steps":["trace[1381872656] 'agreement among raft nodes before linearized reading' (duration: 419.538745ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:50.668936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:49.972603Z","time spent":"696.3249ms","remote":"127.0.0.1:60890","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":"info","ts":"2026-02-26T21:38:50.668987Z","caller":"traceutil/trace.go:171","msg":"trace[1389928498] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:545; }","duration":"619.729187ms","start":"2026-02-26T21:38:50.049233Z","end":"2026-02-26T21:38:50.668962Z","steps":["trace[1389928498] 'agreement among raft nodes before linearized reading' (duration: 619.549973ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:50.66902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:50.249191Z","time spent":"419.782651ms","remote":"127.0.0.1:60720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4356,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"warn","ts":"2026-02-26T21:38:50.669037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:50.049219Z","time spent":"619.808858ms","remote":"127.0.0.1:60720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":13252,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"info","ts":"2026-02-26T21:38:50.66902Z","caller":"traceutil/trace.go:171","msg":"trace[1926351500] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"217.951394ms","start":"2026-02-26T21:38:50.451036Z","end":"2026-02-26T21:38:50.668988Z","steps":["trace[1926351500] 'process raft request' (duration: 217.521915ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:38:50.673364Z","caller":"traceutil/trace.go:171","msg":"trace[1643768795] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"162.277262ms","start":"2026-02-26T21:38:50.511072Z","end":"2026-02-26T21:38:50.673349Z","steps":["trace[1643768795] 'process raft request' (duration: 162.131399ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:38:53.090352Z","caller":"traceutil/trace.go:171","msg":"trace[1099724125] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"447.256674ms","start":"2026-02-26T21:38:52.642943Z","end":"2026-02-26T21:38:53.090199Z","steps":["trace[1099724125] 'process raft request' (duration: 446.705792ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:53.090528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:52.642923Z","time spent":"447.527089ms","remote":"127.0.0.1:60810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4680,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:38:53.090529Z","caller":"traceutil/trace.go:171","msg":"trace[1998408271] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:579; }","duration":"440.109859ms","start":"2026-02-26T21:38:52.649693Z","end":"2026-02-26T21:38:53.089803Z","steps":["trace[1998408271] 'read index received' (duration: 439.901405ms)","trace[1998408271] 'applied index is now lower than readState.Index' (duration: 207.584µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:38:53.090721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.006039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:38:53.090787Z","caller":"traceutil/trace.go:171","msg":"trace[132158205] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:564; }","duration":"441.123551ms","start":"2026-02-26T21:38:52.649644Z","end":"2026-02-26T21:38:53.090768Z","steps":["trace[132158205] 'agreement among raft nodes before linearized reading' (duration: 440.187581ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:53.090815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:52.64962Z","time spent":"441.187663ms","remote":"127.0.0.1:36310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 "} {"level":"warn","ts":"2026-02-26T21:38:53.090856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.156392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:38:53.09089Z","caller":"traceutil/trace.go:171","msg":"trace[1315875418] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:564; }","duration":"441.190683ms","start":"2026-02-26T21:38:52.649687Z","end":"2026-02-26T21:38:53.090877Z","steps":["trace[1315875418] 'agreement among raft nodes before linearized reading' (duration: 440.13773ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:53.090921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:52.649638Z","time spent":"441.276085ms","remote":"127.0.0.1:36310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-02-26T21:38:53.091136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.367597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:38:53.091171Z","caller":"traceutil/trace.go:171","msg":"trace[838274192] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:564; }","duration":"441.407328ms","start":"2026-02-26T21:38:52.649747Z","end":"2026-02-26T21:38:53.091154Z","steps":["trace[838274192] 'agreement among raft nodes before linearized reading' (duration: 441.359307ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:53.091192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:52.649741Z","time spent":"441.443868ms","remote":"127.0.0.1:36310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 "} {"level":"warn","ts":"2026-02-26T21:38:53.091442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.104843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-02-26T21:38:53.091468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.503972ms","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-02-26T21:38:53.091503Z","caller":"traceutil/trace.go:171","msg":"trace[1617180191] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:564; }","duration":"411.538713ms","start":"2026-02-26T21:38:52.679946Z","end":"2026-02-26T21:38:53.091485Z","steps":["trace[1617180191] 'agreement among raft nodes before linearized reading' (duration: 411.443481ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:38:53.091508Z","caller":"traceutil/trace.go:171","msg":"trace[2036938963] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:564; }","duration":"410.168034ms","start":"2026-02-26T21:38:52.681309Z","end":"2026-02-26T21:38:53.091477Z","steps":["trace[2036938963] 'agreement among raft nodes before linearized reading' (duration: 410.057381ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:53.091524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:52.679939Z","time spent":"411.578534ms","remote":"127.0.0.1:60890","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-02-26T21:38:53.091551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:52.681304Z","time spent":"410.235585ms","remote":"127.0.0.1:60890","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-02-26T21:38:53.091977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.994084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:38:53.092029Z","caller":"traceutil/trace.go:171","msg":"trace[212408] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:564; }","duration":"413.028646ms","start":"2026-02-26T21:38:52.678964Z","end":"2026-02-26T21:38:53.091993Z","steps":["trace[212408] 'agreement among raft nodes before linearized reading' (duration: 412.668638ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:53.092058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.552087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:38:53.092093Z","caller":"traceutil/trace.go:171","msg":"trace[2128302685] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:564; }","duration":"413.595058ms","start":"2026-02-26T21:38:52.678482Z","end":"2026-02-26T21:38:53.092077Z","steps":["trace[2128302685] 'agreement among raft nodes before linearized reading' (duration: 413.553737ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:53.092122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:52.678473Z","time spent":"413.633408ms","remote":"127.0.0.1:36320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":113,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-02-26T21:38:53.092159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.154959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T21:38:53.092196Z","caller":"traceutil/trace.go:171","msg":"trace[914867689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:564; }","duration":"414.209811ms","start":"2026-02-26T21:38:52.677975Z","end":"2026-02-26T21:38:53.092185Z","steps":["trace[914867689] 'agreement among raft nodes before linearized reading' (duration: 414.100969ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:53.092218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:52.677955Z","time spent":"414.256702ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T21:38:53.092211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.669005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:38:53.092275Z","caller":"traceutil/trace.go:171","msg":"trace[612028608] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:564; }","duration":"297.756458ms","start":"2026-02-26T21:38:52.794502Z","end":"2026-02-26T21:38:53.092258Z","steps":["trace[612028608] 'agreement among raft nodes before linearized reading' (duration: 297.4071ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:53.092323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.629829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:38:53.092347Z","caller":"traceutil/trace.go:171","msg":"trace[1800335737] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:564; }","duration":"413.672689ms","start":"2026-02-26T21:38:52.678666Z","end":"2026-02-26T21:38:53.092339Z","steps":["trace[1800335737] 'agreement among raft nodes before linearized reading' (duration: 413.630999ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:53.092374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:52.678661Z","time spent":"413.70683ms","remote":"127.0.0.1:36320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-26T21:38:53.092056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:52.678959Z","time spent":"413.089367ms","remote":"127.0.0.1:36320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 "} {"level":"warn","ts":"2026-02-26T21:38:53.092741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.439667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:38:53.092776Z","caller":"traceutil/trace.go:171","msg":"trace[1916961985] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:564; }","duration":"383.477077ms","start":"2026-02-26T21:38:52.709281Z","end":"2026-02-26T21:38:53.092758Z","steps":["trace[1916961985] 'agreement among raft nodes before linearized reading' (duration: 383.428116ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:53.092799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:52.70927Z","time spent":"383.521358ms","remote":"127.0.0.1:36332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 "} {"level":"warn","ts":"2026-02-26T21:38:53.092803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.559099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:38:53.092832Z","caller":"traceutil/trace.go:171","msg":"trace[662433434] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:564; }","duration":"383.612861ms","start":"2026-02-26T21:38:52.709203Z","end":"2026-02-26T21:38:53.092816Z","steps":["trace[662433434] 'agreement among raft nodes before linearized reading' (duration: 383.56672ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:53.092849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:52.709185Z","time spent":"383.658881ms","remote":"127.0.0.1:36332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-26T21:38:53.09297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.59497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:38:53.092999Z","caller":"traceutil/trace.go:171","msg":"trace[1407979853] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:564; }","duration":"383.637481ms","start":"2026-02-26T21:38:52.709354Z","end":"2026-02-26T21:38:53.092991Z","steps":["trace[1407979853] 'agreement among raft nodes before linearized reading' (duration: 383.59212ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:53.093026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:52.709348Z","time spent":"383.665771ms","remote":"127.0.0.1:36332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 "} {"level":"info","ts":"2026-02-26T21:38:54.778713Z","caller":"traceutil/trace.go:171","msg":"trace[979075960] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"254.148166ms","start":"2026-02-26T21:38:54.524542Z","end":"2026-02-26T21:38:54.778691Z","steps":["trace[979075960] 'process raft request' (duration: 254.019483ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:38:55.576024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.705927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-26T21:38:55.57607Z","caller":"traceutil/trace.go:171","msg":"trace[927028491] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:578; }","duration":"146.814759ms","start":"2026-02-26T21:38:55.429244Z","end":"2026-02-26T21:38:55.576058Z","steps":["trace[927028491] 'range keys from in-memory index tree' (duration: 146.586944ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:38:55.708321Z","caller":"traceutil/trace.go:171","msg":"trace[1239859335] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"128.336299ms","start":"2026-02-26T21:38:55.579964Z","end":"2026-02-26T21:38:55.7083Z","steps":["trace[1239859335] 'process raft request' (duration: 128.203777ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:00.701457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.580511095s","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-02-26T21:39:00.701879Z","caller":"traceutil/trace.go:171","msg":"trace[1662953260] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:580; }","duration":"3.580982594s","start":"2026-02-26T21:38:57.120872Z","end":"2026-02-26T21:39:00.701855Z","steps":["trace[1662953260] 'range keys from in-memory index tree' (duration: 3.580374891s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:00.701488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.574048445s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-02-26T21:39:00.701884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.58403154s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-02-26T21:39:00.701935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:57.120853Z","time spent":"3.581070947s","remote":"127.0.0.1:60890","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":"info","ts":"2026-02-26T21:39:00.701987Z","caller":"traceutil/trace.go:171","msg":"trace[925019733] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:580; }","duration":"3.584175914s","start":"2026-02-26T21:38:57.117788Z","end":"2026-02-26T21:39:00.701964Z","steps":["trace[925019733] 'range keys from in-memory index tree' (duration: 3.583945459s)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:00.701984Z","caller":"traceutil/trace.go:171","msg":"trace[970484843] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"3.574547396s","start":"2026-02-26T21:38:57.127412Z","end":"2026-02-26T21:39:00.70196Z","steps":["trace[970484843] 'range keys from in-memory index tree' (duration: 3.574002204s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:00.702031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:57.117776Z","time spent":"3.584245445s","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-26T21:39:00.702087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:57.127407Z","time spent":"3.574652388s","remote":"127.0.0.1:60890","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-02-26T21:39:00.701488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.989874725s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-26T21:39:00.70222Z","caller":"traceutil/trace.go:171","msg":"trace[1999318099] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:580; }","duration":"2.990647512s","start":"2026-02-26T21:38:57.711558Z","end":"2026-02-26T21:39:00.702205Z","steps":["trace[1999318099] 'range keys from in-memory index tree' (duration: 2.989740862s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:00.702259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:57.711539Z","time spent":"2.990709324s","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T21:39:00.701541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.85504871s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-26T21:39:00.702448Z","caller":"traceutil/trace.go:171","msg":"trace[1529618229] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:580; }","duration":"1.855998461s","start":"2026-02-26T21:38:58.846439Z","end":"2026-02-26T21:39:00.702437Z","steps":["trace[1529618229] 'range keys from in-memory index tree' (duration: 1.854966928s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:00.702481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:58.846418Z","time spent":"1.856053262s","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-26T21:39:00.701653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.906045291s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:39:00.702853Z","caller":"traceutil/trace.go:171","msg":"trace[756072268] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"1.907285168s","start":"2026-02-26T21:38:58.795557Z","end":"2026-02-26T21:39:00.702842Z","steps":["trace[756072268] 'range keys from in-memory index tree' (duration: 1.905952399s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:00.702883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:38:58.795536Z","time spent":"1.9073384s","remote":"127.0.0.1:60674","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-02-26T21:39:00.701735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.921589242s","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-02-26T21:39:00.702937Z","caller":"traceutil/trace.go:171","msg":"trace[2089068942] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:580; }","duration":"2.922788848s","start":"2026-02-26T21:38:57.780129Z","end":"2026-02-26T21:39:00.702918Z","steps":["trace[2089068942] 'range keys from in-memory index tree' (duration: 2.921582971s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:01.212917Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810625527844873,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T21:39:01.50094Z","caller":"traceutil/trace.go:171","msg":"trace[1165504311] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"795.288511ms","start":"2026-02-26T21:39:00.705624Z","end":"2026-02-26T21:39:01.500913Z","steps":["trace[1165504311] 'process raft request' (duration: 795.123908ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:01.501101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:00.705604Z","time spent":"795.410653ms","remote":"127.0.0.1:60890","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-02-26T21:39:01.658869Z","caller":"traceutil/trace.go:171","msg":"trace[517634435] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"953.028509ms","start":"2026-02-26T21:39:00.70582Z","end":"2026-02-26T21:39:01.658849Z","steps":["trace[517634435] 'process raft request' (duration: 952.867765ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:01.658998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:00.705795Z","time spent":"953.13339ms","remote":"127.0.0.1:60890","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-02-26T21:39:01.659185Z","caller":"traceutil/trace.go:171","msg":"trace[1254070428] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"953.315275ms","start":"2026-02-26T21:39:00.705847Z","end":"2026-02-26T21:39:01.659163Z","steps":["trace[1254070428] 'process raft request' (duration: 952.952696ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:01.659312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:00.705833Z","time spent":"953.407226ms","remote":"127.0.0.1:60890","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-02-26T21:39:01.659357Z","caller":"traceutil/trace.go:171","msg":"trace[999795994] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"952.951167ms","start":"2026-02-26T21:39:00.706398Z","end":"2026-02-26T21:39:01.659349Z","steps":["trace[999795994] 'process raft request' (duration: 952.694761ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:01.659401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:00.706385Z","time spent":"952.992057ms","remote":"127.0.0.1:60890","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-02-26T21:39:01.65956Z","caller":"traceutil/trace.go:171","msg":"trace[455752714] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"951.443743ms","start":"2026-02-26T21:39:00.70811Z","end":"2026-02-26T21:39:01.659553Z","steps":["trace[455752714] 'process raft request' (duration: 951.211948ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:01.659597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:00.708093Z","time spent":"951.482334ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:39:01.659734Z","caller":"traceutil/trace.go:171","msg":"trace[1156032687] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:597; }","duration":"947.281751ms","start":"2026-02-26T21:39:00.712439Z","end":"2026-02-26T21:39:01.659721Z","steps":["trace[1156032687] 'read index received' (duration: 788.336377ms)","trace[1156032687] 'applied index is now lower than readState.Index' (duration: 158.944324ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:39:01.659881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"947.431404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:39:01.659875Z","caller":"traceutil/trace.go:171","msg":"trace[518383261] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"537.785273ms","start":"2026-02-26T21:39:01.122069Z","end":"2026-02-26T21:39:01.659855Z","steps":["trace[518383261] 'process raft request' (duration: 537.457966ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:01.659912Z","caller":"traceutil/trace.go:171","msg":"trace[1154808054] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"947.503096ms","start":"2026-02-26T21:39:00.712399Z","end":"2026-02-26T21:39:01.659902Z","steps":["trace[1154808054] 'agreement among raft nodes before linearized reading' (duration: 947.428064ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:01.659933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:00.712388Z","time spent":"947.539066ms","remote":"127.0.0.1:60674","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-02-26T21:39:01.659964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.457842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.227\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-02-26T21:39:01.65997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:01.122051Z","time spent":"537.866204ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:39:01.659996Z","caller":"traceutil/trace.go:171","msg":"trace[1566234431] range","detail":"{range_begin:/registry/masterleases/162.253.55.227; range_end:; response_count:1; response_revision:586; }","duration":"199.526644ms","start":"2026-02-26T21:39:01.460459Z","end":"2026-02-26T21:39:01.659986Z","steps":["trace[1566234431] 'agreement among raft nodes before linearized reading' (duration: 199.419341ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:04.553994Z","caller":"traceutil/trace.go:171","msg":"trace[924309710] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"182.473946ms","start":"2026-02-26T21:39:04.371496Z","end":"2026-02-26T21:39:04.55397Z","steps":["trace[924309710] 'process raft request' (duration: 182.304282ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:04.642861Z","caller":"traceutil/trace.go:171","msg":"trace[337882172] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"258.979442ms","start":"2026-02-26T21:39:04.383856Z","end":"2026-02-26T21:39:04.642835Z","steps":["trace[337882172] 'process raft request' (duration: 247.699472ms)","trace[337882172] 'compare' (duration: 11.186368ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:39:05.51548Z","caller":"traceutil/trace.go:171","msg":"trace[1101473850] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"136.992318ms","start":"2026-02-26T21:39:05.378459Z","end":"2026-02-26T21:39:05.515452Z","steps":["trace[1101473850] 'read index received' (duration: 136.742012ms)","trace[1101473850] 'applied index is now lower than readState.Index' (duration: 248.306µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:39:05.515712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.242903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dtbw4\" ","response":"range_response_count:1 size:17790"} {"level":"info","ts":"2026-02-26T21:39:05.515505Z","caller":"traceutil/trace.go:171","msg":"trace[304117394] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"428.9585ms","start":"2026-02-26T21:39:05.086519Z","end":"2026-02-26T21:39:05.515477Z","steps":["trace[304117394] 'process raft request' (duration: 428.765726ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:05.51575Z","caller":"traceutil/trace.go:171","msg":"trace[89722024] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dtbw4; range_end:; response_count:1; response_revision:605; }","duration":"137.356355ms","start":"2026-02-26T21:39:05.378385Z","end":"2026-02-26T21:39:05.515741Z","steps":["trace[89722024] 'agreement among raft nodes before linearized reading' (duration: 137.167211ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:05.515854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:05.086498Z","time spent":"429.285117ms","remote":"127.0.0.1:60732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":700,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:39:05.982164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.807889ms","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-02-26T21:39:05.98226Z","caller":"traceutil/trace.go:171","msg":"trace[1362007552] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:607; }","duration":"309.959861ms","start":"2026-02-26T21:39:05.672278Z","end":"2026-02-26T21:39:05.982238Z","steps":["trace[1362007552] 'range keys from in-memory index tree' (duration: 309.571733ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:05.982272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.501283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T21:39:05.982303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:05.672261Z","time spent":"310.032253ms","remote":"127.0.0.1:60890","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-02-26T21:39:05.982301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.205826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-26T21:39:05.982325Z","caller":"traceutil/trace.go:171","msg":"trace[741683110] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"185.583635ms","start":"2026-02-26T21:39:05.796725Z","end":"2026-02-26T21:39:05.982308Z","steps":["trace[741683110] 'range keys from in-memory index tree' (duration: 185.39847ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:05.982397Z","caller":"traceutil/trace.go:171","msg":"trace[1026307696] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:607; }","duration":"305.358089ms","start":"2026-02-26T21:39:05.677016Z","end":"2026-02-26T21:39:05.982374Z","steps":["trace[1026307696] 'range keys from in-memory index tree' (duration: 304.999012ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:05.982388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.979639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-26T21:39:05.982664Z","caller":"traceutil/trace.go:171","msg":"trace[1154566091] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:607; }","duration":"304.303646ms","start":"2026-02-26T21:39:05.678333Z","end":"2026-02-26T21:39:05.982637Z","steps":["trace[1154566091] 'range keys from in-memory index tree' (duration: 303.820225ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:05.982737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:05.678326Z","time spent":"304.393648ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-26T21:39:05.983049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.351925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-26T21:39:05.982451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:05.676998Z","time spent":"305.444052ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-26T21:39:05.983154Z","caller":"traceutil/trace.go:171","msg":"trace[2145946619] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:607; }","duration":"304.308596ms","start":"2026-02-26T21:39:05.678826Z","end":"2026-02-26T21:39:05.983134Z","steps":["trace[2145946619] 'range keys from in-memory index tree' (duration: 303.200901ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:05.983901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:05.678819Z","time spent":"305.053832ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-26T21:39:07.60792Z","caller":"traceutil/trace.go:171","msg":"trace[847863789] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"205.086857ms","start":"2026-02-26T21:39:07.402808Z","end":"2026-02-26T21:39:07.607895Z","steps":["trace[847863789] 'process raft request' (duration: 204.903583ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:07.734393Z","caller":"traceutil/trace.go:171","msg":"trace[1122203525] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:634; }","duration":"192.054638ms","start":"2026-02-26T21:39:07.54232Z","end":"2026-02-26T21:39:07.734374Z","steps":["trace[1122203525] 'read index received' (duration: 65.436651ms)","trace[1122203525] 'applied index is now lower than readState.Index' (duration: 126.617147ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:39:07.734567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.234152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T21:39:07.734598Z","caller":"traceutil/trace.go:171","msg":"trace[1540262202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:617; }","duration":"192.322383ms","start":"2026-02-26T21:39:07.542266Z","end":"2026-02-26T21:39:07.734588Z","steps":["trace[1540262202] 'agreement among raft nodes before linearized reading' (duration: 192.18036ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:07.734568Z","caller":"traceutil/trace.go:171","msg":"trace[31371554] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"313.697715ms","start":"2026-02-26T21:39:07.420823Z","end":"2026-02-26T21:39:07.734521Z","steps":["trace[31371554] 'process raft request' (duration: 313.403788ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:07.734809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:07.420794Z","time spent":"313.886058ms","remote":"127.0.0.1:60812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18322,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:39:07.89273Z","caller":"traceutil/trace.go:171","msg":"trace[60058344] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"138.433669ms","start":"2026-02-26T21:39:07.754272Z","end":"2026-02-26T21:39:07.892706Z","steps":["trace[60058344] 'process raft request' (duration: 137.13905ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:08.212146Z","caller":"traceutil/trace.go:171","msg":"trace[837175667] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"147.705155ms","start":"2026-02-26T21:39:08.06442Z","end":"2026-02-26T21:39:08.212125Z","steps":["trace[837175667] 'read index received' (duration: 147.48609ms)","trace[837175667] 'applied index is now lower than readState.Index' (duration: 215.974µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:39:08.212267Z","caller":"traceutil/trace.go:171","msg":"trace[384683050] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"163.7782ms","start":"2026-02-26T21:39:08.048479Z","end":"2026-02-26T21:39:08.212257Z","steps":["trace[384683050] 'process raft request' (duration: 163.454643ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:08.212395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.529301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-26T21:39:08.212417Z","caller":"traceutil/trace.go:171","msg":"trace[449119807] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:619; }","duration":"147.580572ms","start":"2026-02-26T21:39:08.06483Z","end":"2026-02-26T21:39:08.212411Z","steps":["trace[449119807] 'agreement among raft nodes before linearized reading' (duration: 147.49061ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:08.212542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.572172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-26T21:39:08.212568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.150475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-26T21:39:08.212573Z","caller":"traceutil/trace.go:171","msg":"trace[886223216] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:619; }","duration":"147.627043ms","start":"2026-02-26T21:39:08.064935Z","end":"2026-02-26T21:39:08.212563Z","steps":["trace[886223216] 'agreement among raft nodes before linearized reading' (duration: 147.547881ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:08.212583Z","caller":"traceutil/trace.go:171","msg":"trace[486715888] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:619; }","duration":"148.196776ms","start":"2026-02-26T21:39:08.064382Z","end":"2026-02-26T21:39:08.212579Z","steps":["trace[486715888] 'agreement among raft nodes before linearized reading' (duration: 148.156295ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:09.116582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.760143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dtbw4\" ","response":"range_response_count:1 size:18337"} {"level":"info","ts":"2026-02-26T21:39:09.116632Z","caller":"traceutil/trace.go:171","msg":"trace[2071971151] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dtbw4; range_end:; response_count:1; response_revision:624; }","duration":"708.852015ms","start":"2026-02-26T21:39:08.407768Z","end":"2026-02-26T21:39:09.11662Z","steps":["trace[2071971151] 'range keys from in-memory index tree' (duration: 708.64291ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:09.116654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:08.407752Z","time spent":"708.896996ms","remote":"127.0.0.1:60812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18360,"request content":"key:\"/registry/pods/kube-system/cilium-dtbw4\" "} {"level":"warn","ts":"2026-02-26T21:39:10.294647Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810625527844954,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T21:39:10.500061Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.369323067s","expected-duration":"1s"} {"level":"info","ts":"2026-02-26T21:39:10.500412Z","caller":"traceutil/trace.go:171","msg":"trace[1305698121] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"706.679266ms","start":"2026-02-26T21:39:09.793715Z","end":"2026-02-26T21:39:10.500394Z","steps":["trace[1305698121] 'read index received' (duration: 706.471421ms)","trace[1305698121] 'applied index is now lower than readState.Index' (duration: 207.225µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:39:10.500476Z","caller":"traceutil/trace.go:171","msg":"trace[1233262147] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"1.369896149s","start":"2026-02-26T21:39:09.130574Z","end":"2026-02-26T21:39:10.50047Z","steps":["trace[1233262147] 'process raft request' (duration: 1.369702455s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:10.500577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:09.130493Z","time spent":"1.370006072s","remote":"127.0.0.1:60812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18506,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:39:10.500685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"706.967062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:39:10.50071Z","caller":"traceutil/trace.go:171","msg":"trace[176078063] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"707.016594ms","start":"2026-02-26T21:39:09.793687Z","end":"2026-02-26T21:39:10.500703Z","steps":["trace[176078063] 'agreement among raft nodes before linearized reading' (duration: 706.977333ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:10.500731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:09.79367Z","time spent":"707.057134ms","remote":"127.0.0.1:60674","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-02-26T21:39:10.500912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.930078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T21:39:10.500937Z","caller":"traceutil/trace.go:171","msg":"trace[849701138] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:625; }","duration":"603.98433ms","start":"2026-02-26T21:39:09.896947Z","end":"2026-02-26T21:39:10.500931Z","steps":["trace[849701138] 'agreement among raft nodes before linearized reading' (duration: 603.903518ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:10.500955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:09.896931Z","time spent":"604.01895ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T21:39:10.501082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.155087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-02-26T21:39:10.501082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.602034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-02-26T21:39:10.501155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.076154ms","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-02-26T21:39:10.50119Z","caller":"traceutil/trace.go:171","msg":"trace[1519157638] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:625; }","duration":"263.732477ms","start":"2026-02-26T21:39:10.237431Z","end":"2026-02-26T21:39:10.501163Z","steps":["trace[1519157638] 'agreement among raft nodes before linearized reading' (duration: 263.458391ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:10.501187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.167865ms","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-02-26T21:39:10.501229Z","caller":"traceutil/trace.go:171","msg":"trace[1477664916] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:625; }","duration":"264.200257ms","start":"2026-02-26T21:39:10.237015Z","end":"2026-02-26T21:39:10.501215Z","steps":["trace[1477664916] 'agreement among raft nodes before linearized reading' (duration: 264.045944ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:10.501265Z","caller":"traceutil/trace.go:171","msg":"trace[700749712] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:625; }","duration":"286.281087ms","start":"2026-02-26T21:39:10.214963Z","end":"2026-02-26T21:39:10.501244Z","steps":["trace[700749712] 'agreement among raft nodes before linearized reading' (duration: 286.044801ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:10.501114Z","caller":"traceutil/trace.go:171","msg":"trace[773554666] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:625; }","duration":"264.204778ms","start":"2026-02-26T21:39:10.236902Z","end":"2026-02-26T21:39:10.501106Z","steps":["trace[773554666] 'agreement among raft nodes before linearized reading' (duration: 264.101785ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:10.840592Z","caller":"traceutil/trace.go:171","msg":"trace[955457483] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"335.247562ms","start":"2026-02-26T21:39:10.505314Z","end":"2026-02-26T21:39:10.840562Z","steps":["trace[955457483] 'process raft request' (duration: 289.179731ms)","trace[955457483] 'compare' (duration: 45.790915ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:39:10.8407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:10.505298Z","time spent":"335.344114ms","remote":"127.0.0.1:60890","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-02-26T21:39:10.933915Z","caller":"traceutil/trace.go:171","msg":"trace[1802532977] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"428.51505ms","start":"2026-02-26T21:39:10.505383Z","end":"2026-02-26T21:39:10.933898Z","steps":["trace[1802532977] 'process raft request' (duration: 428.443729ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:10.933931Z","caller":"traceutil/trace.go:171","msg":"trace[1358724946] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"428.54908ms","start":"2026-02-26T21:39:10.505349Z","end":"2026-02-26T21:39:10.933898Z","steps":["trace[1358724946] 'process raft request' (duration: 428.384477ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:10.934097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:10.505332Z","time spent":"428.675804ms","remote":"127.0.0.1:60890","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-02-26T21:39:10.934051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:10.505362Z","time spent":"428.610272ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:39:10.934168Z","caller":"traceutil/trace.go:171","msg":"trace[1544605284] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"428.735125ms","start":"2026-02-26T21:39:10.505421Z","end":"2026-02-26T21:39:10.934156Z","steps":["trace[1544605284] 'process raft request' (duration: 428.440478ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:10.934162Z","caller":"traceutil/trace.go:171","msg":"trace[1488343073] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:645; }","duration":"137.675893ms","start":"2026-02-26T21:39:10.796466Z","end":"2026-02-26T21:39:10.934142Z","steps":["trace[1488343073] 'read index received' (duration: 137.255283ms)","trace[1488343073] 'applied index is now lower than readState.Index' (duration: 419.33µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:39:10.934227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:10.505412Z","time spent":"428.788296ms","remote":"127.0.0.1:60890","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-02-26T21:39:10.934202Z","caller":"traceutil/trace.go:171","msg":"trace[382455070] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"428.54597ms","start":"2026-02-26T21:39:10.50563Z","end":"2026-02-26T21:39:10.934176Z","steps":["trace[382455070] 'process raft request' (duration: 428.413397ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:10.93429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.815085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:39:10.934324Z","caller":"traceutil/trace.go:171","msg":"trace[1592595292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"137.911338ms","start":"2026-02-26T21:39:10.796405Z","end":"2026-02-26T21:39:10.934317Z","steps":["trace[1592595292] 'agreement among raft nodes before linearized reading' (duration: 137.808055ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:10.934341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:10.505621Z","time spent":"428.645052ms","remote":"127.0.0.1:60890","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-02-26T21:39:20.996821Z","caller":"traceutil/trace.go:171","msg":"trace[663911464] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"115.935621ms","start":"2026-02-26T21:39:20.880855Z","end":"2026-02-26T21:39:20.99679Z","steps":["trace[663911464] 'process raft request' (duration: 115.745646ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:21.115792Z","caller":"traceutil/trace.go:171","msg":"trace[1255660370] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"114.730023ms","start":"2026-02-26T21:39:21.001045Z","end":"2026-02-26T21:39:21.115775Z","steps":["trace[1255660370] 'process raft request' (duration: 114.620081ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:21.116033Z","caller":"traceutil/trace.go:171","msg":"trace[351339206] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"112.270119ms","start":"2026-02-26T21:39:21.003727Z","end":"2026-02-26T21:39:21.115997Z","steps":["trace[351339206] 'process raft request' (duration: 112.204088ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:21.116045Z","caller":"traceutil/trace.go:171","msg":"trace[817310191] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"114.801385ms","start":"2026-02-26T21:39:21.001231Z","end":"2026-02-26T21:39:21.116033Z","steps":["trace[817310191] 'process raft request' (duration: 114.516259ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:27.389078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.867815ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-02-26T21:39:27.389289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:26.720725Z","time spent":"668.556811ms","remote":"127.0.0.1:60732","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-26T21:39:27.389224Z","caller":"traceutil/trace.go:171","msg":"trace[550400184] linearizableReadLoop","detail":"{readStateIndex:775; appliedIndex:773; }","duration":"369.909091ms","start":"2026-02-26T21:39:27.019302Z","end":"2026-02-26T21:39:27.389211Z","steps":["trace[550400184] 'read index received' (duration: 181.571845ms)","trace[550400184] 'applied index is now lower than readState.Index' (duration: 188.336056ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:39:27.389554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.238158ms","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-02-26T21:39:27.389647Z","caller":"traceutil/trace.go:171","msg":"trace[748948031] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:749; }","duration":"370.368891ms","start":"2026-02-26T21:39:27.01927Z","end":"2026-02-26T21:39:27.389639Z","steps":["trace[748948031] 'agreement among raft nodes before linearized reading' (duration: 370.156487ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:27.389674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:27.019254Z","time spent":"370.412182ms","remote":"127.0.0.1:60890","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-02-26T21:39:27.389771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.177955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-02-26T21:39:27.3898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.238209ms","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-02-26T21:39:27.389828Z","caller":"traceutil/trace.go:171","msg":"trace[1953639446] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:749; }","duration":"254.255416ms","start":"2026-02-26T21:39:27.135554Z","end":"2026-02-26T21:39:27.389809Z","steps":["trace[1953639446] 'agreement among raft nodes before linearized reading' (duration: 254.085862ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:27.389838Z","caller":"traceutil/trace.go:171","msg":"trace[1316544241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:749; }","duration":"255.317681ms","start":"2026-02-26T21:39:27.134508Z","end":"2026-02-26T21:39:27.389825Z","steps":["trace[1316544241] 'agreement among raft nodes before linearized reading' (duration: 255.221538ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:27.389871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.008733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-02-26T21:39:27.389872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.430482ms","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-02-26T21:39:27.38991Z","caller":"traceutil/trace.go:171","msg":"trace[2111469925] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:749; }","duration":"324.078444ms","start":"2026-02-26T21:39:27.065825Z","end":"2026-02-26T21:39:27.389904Z","steps":["trace[2111469925] 'agreement among raft nodes before linearized reading' (duration: 323.776728ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:27.389932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:27.065808Z","time spent":"324.118496ms","remote":"127.0.0.1:60890","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-02-26T21:39:27.389925Z","caller":"traceutil/trace.go:171","msg":"trace[1477775467] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:749; }","duration":"255.511634ms","start":"2026-02-26T21:39:27.134394Z","end":"2026-02-26T21:39:27.389905Z","steps":["trace[1477775467] 'agreement among raft nodes before linearized reading' (duration: 255.366941ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:27.861101Z","caller":"traceutil/trace.go:171","msg":"trace[540920714] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"470.658505ms","start":"2026-02-26T21:39:27.390414Z","end":"2026-02-26T21:39:27.861073Z","steps":["trace[540920714] 'process raft request' (duration: 408.931006ms)","trace[540920714] 'compare' (duration: 61.503974ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:39:27.861243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:27.390393Z","time spent":"470.784818ms","remote":"127.0.0.1:60732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":813,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T21:39:28.266639Z","caller":"traceutil/trace.go:171","msg":"trace[2078236785] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"872.736698ms","start":"2026-02-26T21:39:27.393878Z","end":"2026-02-26T21:39:28.266615Z","steps":["trace[2078236785] 'process raft request' (duration: 872.680657ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:28.266688Z","caller":"traceutil/trace.go:171","msg":"trace[366073925] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"873.115076ms","start":"2026-02-26T21:39:27.393545Z","end":"2026-02-26T21:39:28.26666Z","steps":["trace[366073925] 'process raft request' (duration: 780.724548ms)","trace[366073925] 'compare' (duration: 92.213994ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:39:28.2668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:27.393525Z","time spent":"873.212308ms","remote":"127.0.0.1:60890","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-02-26T21:39:28.266821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:27.393854Z","time spent":"872.85442ms","remote":"127.0.0.1:60890","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-02-26T21:39:28.266965Z","caller":"traceutil/trace.go:171","msg":"trace[624454795] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"872.749568ms","start":"2026-02-26T21:39:27.394191Z","end":"2026-02-26T21:39:28.266941Z","steps":["trace[624454795] 'process raft request' (duration: 872.602705ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:28.267006Z","caller":"traceutil/trace.go:171","msg":"trace[563268589] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"872.920902ms","start":"2026-02-26T21:39:27.394078Z","end":"2026-02-26T21:39:28.266999Z","steps":["trace[563268589] 'process raft request' (duration: 872.504152ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:28.266996Z","caller":"traceutil/trace.go:171","msg":"trace[1064524534] linearizableReadLoop","detail":"{readStateIndex:781; appliedIndex:775; }","duration":"778.720133ms","start":"2026-02-26T21:39:27.48826Z","end":"2026-02-26T21:39:28.26698Z","steps":["trace[1064524534] 'read index received' (duration: 311.162059ms)","trace[1064524534] 'applied index is now lower than readState.Index' (duration: 467.557184ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:39:28.267047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:27.394067Z","time spent":"872.958852ms","remote":"127.0.0.1:60890","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-02-26T21:39:28.26709Z","caller":"traceutil/trace.go:171","msg":"trace[973495643] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"871.602452ms","start":"2026-02-26T21:39:27.395478Z","end":"2026-02-26T21:39:28.267081Z","steps":["trace[973495643] 'process raft request' (duration: 871.415718ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:28.267103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:27.394171Z","time spent":"872.85492ms","remote":"127.0.0.1:60890","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-02-26T21:39:28.267136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.641437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:39:28.267158Z","caller":"traceutil/trace.go:171","msg":"trace[1651051346] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:755; }","duration":"472.704969ms","start":"2026-02-26T21:39:27.794446Z","end":"2026-02-26T21:39:28.267151Z","steps":["trace[1651051346] 'agreement among raft nodes before linearized reading' (duration: 472.647798ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:28.267152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:27.395461Z","time spent":"871.651254ms","remote":"127.0.0.1:60890","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-02-26T21:39:28.267175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:27.794428Z","time spent":"472.743529ms","remote":"127.0.0.1:60674","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-02-26T21:39:28.267277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.579166ms","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":"warn","ts":"2026-02-26T21:39:28.267285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.03478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:39:28.267317Z","caller":"traceutil/trace.go:171","msg":"trace[999341901] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:755; }","duration":"779.110831ms","start":"2026-02-26T21:39:27.488195Z","end":"2026-02-26T21:39:28.267306Z","steps":["trace[999341901] 'agreement among raft nodes before linearized reading' (duration: 779.06388ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:28.267346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:27.488172Z","time spent":"779.165673ms","remote":"127.0.0.1:32932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-02-26T21:39:28.267338Z","caller":"traceutil/trace.go:171","msg":"trace[1435291181] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:755; }","duration":"181.644577ms","start":"2026-02-26T21:39:28.085656Z","end":"2026-02-26T21:39:28.2673Z","steps":["trace[1435291181] 'agreement among raft nodes before linearized reading' (duration: 181.587516ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:30.649134Z","caller":"traceutil/trace.go:171","msg":"trace[52801216] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"373.355247ms","start":"2026-02-26T21:39:30.275756Z","end":"2026-02-26T21:39:30.649111Z","steps":["trace[52801216] 'process raft request' (duration: 373.224314ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:30.649303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:30.275729Z","time spent":"373.500321ms","remote":"127.0.0.1:60890","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-02-26T21:39:30.831917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.56337ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T21:39:30.83212Z","caller":"traceutil/trace.go:171","msg":"trace[799524205] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"551.063667ms","start":"2026-02-26T21:39:30.281043Z","end":"2026-02-26T21:39:30.832107Z","steps":["trace[799524205] 'process raft request' (duration: 550.982465ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:30.83219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:30.281038Z","time spent":"551.114188ms","remote":"127.0.0.1:60890","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-02-26T21:39:30.832299Z","caller":"traceutil/trace.go:171","msg":"trace[641166401] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"551.343343ms","start":"2026-02-26T21:39:30.280949Z","end":"2026-02-26T21:39:30.832292Z","steps":["trace[641166401] 'process raft request' (duration: 436.320323ms)","trace[641166401] 'compare' (duration: 114.414866ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:39:30.83231Z","caller":"traceutil/trace.go:171","msg":"trace[441292140] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"551.111538ms","start":"2026-02-26T21:39:30.281175Z","end":"2026-02-26T21:39:30.832287Z","steps":["trace[441292140] 'process raft request' (duration: 550.887883ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:30.832359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:30.280933Z","time spent":"551.385965ms","remote":"127.0.0.1:60890","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-02-26T21:39:30.832435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:30.281028Z","time spent":"551.342663ms","remote":"127.0.0.1:60890","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-02-26T21:39:30.832637Z","caller":"traceutil/trace.go:171","msg":"trace[205563113] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"550.023224ms","start":"2026-02-26T21:39:30.282595Z","end":"2026-02-26T21:39:30.832618Z","steps":["trace[205563113] 'process raft request' (duration: 549.625875ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:30.832779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:30.28259Z","time spent":"550.122766ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:39:31.695106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.917204ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T21:39:31.695185Z","caller":"traceutil/trace.go:171","msg":"trace[1679016922] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"179.08572ms","start":"2026-02-26T21:39:31.516085Z","end":"2026-02-26T21:39:31.695171Z","steps":["trace[1679016922] 'process raft request' (duration: 75.041063ms)","trace[1679016922] 'compare' (duration: 103.812902ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:39:32.787902Z","caller":"traceutil/trace.go:171","msg":"trace[1932791146] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"130.973433ms","start":"2026-02-26T21:39:32.656912Z","end":"2026-02-26T21:39:32.787886Z","steps":["trace[1932791146] 'process raft request' (duration: 130.869141ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:32.793804Z","caller":"traceutil/trace.go:171","msg":"trace[1539728387] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"117.077896ms","start":"2026-02-26T21:39:32.676699Z","end":"2026-02-26T21:39:32.793777Z","steps":["trace[1539728387] 'process raft request' (duration: 116.908942ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:34.679049Z","caller":"traceutil/trace.go:171","msg":"trace[1969966763] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"194.520372ms","start":"2026-02-26T21:39:34.48451Z","end":"2026-02-26T21:39:34.67903Z","steps":["trace[1969966763] 'process raft request' (duration: 194.403759ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:35.034392Z","caller":"traceutil/trace.go:171","msg":"trace[946611688] linearizableReadLoop","detail":"{readStateIndex:798; appliedIndex:796; }","duration":"147.378067ms","start":"2026-02-26T21:39:34.886993Z","end":"2026-02-26T21:39:35.034371Z","steps":["trace[946611688] 'read index received' (duration: 30.66847ms)","trace[946611688] 'applied index is now lower than readState.Index' (duration: 116.708787ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:39:35.034531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.52039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T21:39:35.034551Z","caller":"traceutil/trace.go:171","msg":"trace[345213819] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:772; }","duration":"147.567872ms","start":"2026-02-26T21:39:34.886978Z","end":"2026-02-26T21:39:35.034546Z","steps":["trace[345213819] 'agreement among raft nodes before linearized reading' (duration: 147.463499ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:35.034589Z","caller":"traceutil/trace.go:171","msg":"trace[679524391] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"148.576384ms","start":"2026-02-26T21:39:34.885979Z","end":"2026-02-26T21:39:35.034556Z","steps":["trace[679524391] 'process raft request' (duration: 80.548066ms)","trace[679524391] 'compare' (duration: 67.733621ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:39:35.034588Z","caller":"traceutil/trace.go:171","msg":"trace[1513641908] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"146.781484ms","start":"2026-02-26T21:39:34.887775Z","end":"2026-02-26T21:39:35.034556Z","steps":["trace[1513641908] 'process raft request' (duration: 146.567749ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:42.9378Z","caller":"traceutil/trace.go:171","msg":"trace[1439180819] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"100.691902ms","start":"2026-02-26T21:39:42.837094Z","end":"2026-02-26T21:39:42.937786Z","steps":["trace[1439180819] 'process raft request' (duration: 100.60146ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:43.548516Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810625527845319,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T21:39:44.049326Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810625527845319,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T21:39:44.123543Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.136062446s","expected-duration":"1s"} {"level":"info","ts":"2026-02-26T21:39:44.123903Z","caller":"traceutil/trace.go:171","msg":"trace[1956885555] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:824; }","duration":"1.076044516s","start":"2026-02-26T21:39:43.047838Z","end":"2026-02-26T21:39:44.123883Z","steps":["trace[1956885555] 'read index received' (duration: 1.075908503s)","trace[1956885555] 'applied index is now lower than readState.Index' (duration: 134.983µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:39:44.12396Z","caller":"traceutil/trace.go:171","msg":"trace[1095044097] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"1.136562158s","start":"2026-02-26T21:39:42.987364Z","end":"2026-02-26T21:39:44.123926Z","steps":["trace[1095044097] 'process raft request' (duration: 1.136385824s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:44.124091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.07624393s","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-02-26T21:39:44.12412Z","caller":"traceutil/trace.go:171","msg":"trace[1534725529] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:796; }","duration":"1.076352673s","start":"2026-02-26T21:39:43.04776Z","end":"2026-02-26T21:39:44.124113Z","steps":["trace[1534725529] 'agreement among raft nodes before linearized reading' (duration: 1.07622463s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:44.124147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:43.047742Z","time spent":"1.076399153s","remote":"127.0.0.1:60890","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-02-26T21:39:44.124166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:42.987339Z","time spent":"1.136733981s","remote":"127.0.0.1:60890","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-02-26T21:39:44.124241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.025475585s","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-02-26T21:39:44.124292Z","caller":"traceutil/trace.go:171","msg":"trace[1649506685] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:796; }","duration":"1.025550236s","start":"2026-02-26T21:39:43.098729Z","end":"2026-02-26T21:39:44.124279Z","steps":["trace[1649506685] 'agreement among raft nodes before linearized reading' (duration: 1.025432114s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:44.12433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:43.098716Z","time spent":"1.025606767s","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-26T21:39:44.124421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"880.91002ms","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-02-26T21:39:44.124461Z","caller":"traceutil/trace.go:171","msg":"trace[437887470] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:796; }","duration":"880.983971ms","start":"2026-02-26T21:39:43.243466Z","end":"2026-02-26T21:39:44.12445Z","steps":["trace[437887470] 'agreement among raft nodes before linearized reading' (duration: 880.834548ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:44.124519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:43.243425Z","time spent":"881.063293ms","remote":"127.0.0.1:60890","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-02-26T21:39:44.124489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"974.806562ms","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-02-26T21:39:44.12456Z","caller":"traceutil/trace.go:171","msg":"trace[1871506361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:796; }","duration":"974.900373ms","start":"2026-02-26T21:39:43.149651Z","end":"2026-02-26T21:39:44.124551Z","steps":["trace[1871506361] 'agreement among raft nodes before linearized reading' (duration: 974.782121ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:44.124546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.657133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-26T21:39:44.124588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:43.14964Z","time spent":"974.942104ms","remote":"127.0.0.1:60890","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-02-26T21:39:44.12461Z","caller":"traceutil/trace.go:171","msg":"trace[1681385292] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:796; }","duration":"575.812365ms","start":"2026-02-26T21:39:43.548778Z","end":"2026-02-26T21:39:44.124591Z","steps":["trace[1681385292] 'agreement among raft nodes before linearized reading' (duration: 575.638541ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:44.124703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:43.548738Z","time spent":"575.953419ms","remote":"127.0.0.1:60900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":2,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-02-26T21:39:44.813065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.901416ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T21:39:44.813366Z","caller":"traceutil/trace.go:171","msg":"trace[2045097212] linearizableReadLoop","detail":"{readStateIndex:829; appliedIndex:825; }","duration":"536.612567ms","start":"2026-02-26T21:39:44.276732Z","end":"2026-02-26T21:39:44.813345Z","steps":["trace[2045097212] 'read index received' (duration: 349.332825ms)","trace[2045097212] 'applied index is now lower than readState.Index' (duration: 187.278592ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:39:44.813485Z","caller":"traceutil/trace.go:171","msg":"trace[268181019] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"684.634849ms","start":"2026-02-26T21:39:44.128833Z","end":"2026-02-26T21:39:44.813468Z","steps":["trace[268181019] 'process raft request' (duration: 104.232151ms)","trace[268181019] 'compare' (duration: 579.658691ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:39:44.813756Z","caller":"traceutil/trace.go:171","msg":"trace[966102457] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"684.873213ms","start":"2026-02-26T21:39:44.128851Z","end":"2026-02-26T21:39:44.813725Z","steps":["trace[966102457] 'process raft request' (duration: 684.319401ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:44.813766Z","caller":"traceutil/trace.go:171","msg":"trace[1177436781] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"684.878264ms","start":"2026-02-26T21:39:44.128874Z","end":"2026-02-26T21:39:44.813753Z","steps":["trace[1177436781] 'process raft request' (duration: 684.381413ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:44.813832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.095007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T21:39:44.813888Z","caller":"traceutil/trace.go:171","msg":"trace[921626809] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:800; }","duration":"537.189199ms","start":"2026-02-26T21:39:44.276682Z","end":"2026-02-26T21:39:44.813871Z","steps":["trace[921626809] 'agreement among raft nodes before linearized reading' (duration: 537.097737ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:44.813895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:44.128837Z","time spent":"684.980376ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:39:44.813909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:44.128809Z","time spent":"685.025807ms","remote":"127.0.0.1:60890","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-02-26T21:39:44.813895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:44.128849Z","time spent":"684.973435ms","remote":"127.0.0.1:60890","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-02-26T21:39:44.813931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:44.276665Z","time spent":"537.25237ms","remote":"127.0.0.1:32868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-02-26T21:39:44.813504Z","caller":"traceutil/trace.go:171","msg":"trace[1927979990] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"682.735837ms","start":"2026-02-26T21:39:44.130741Z","end":"2026-02-26T21:39:44.813477Z","steps":["trace[1927979990] 'process raft request' (duration: 682.561143ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:44.814344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:44.130719Z","time spent":"683.588265ms","remote":"127.0.0.1:60890","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-02-26T21:39:46.074567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"946.792528ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T21:39:46.074667Z","caller":"traceutil/trace.go:171","msg":"trace[760815928] linearizableReadLoop","detail":"{readStateIndex:830; appliedIndex:829; }","duration":"277.610584ms","start":"2026-02-26T21:39:45.79704Z","end":"2026-02-26T21:39:46.07465Z","steps":["trace[760815928] 'read index received' (duration: 38.781µs)","trace[760815928] 'applied index is now lower than readState.Index' (duration: 277.570383ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:39:46.07475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.716116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:39:46.074774Z","caller":"traceutil/trace.go:171","msg":"trace[582095930] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:801; }","duration":"277.778028ms","start":"2026-02-26T21:39:45.796988Z","end":"2026-02-26T21:39:46.074766Z","steps":["trace[582095930] 'agreement among raft nodes before linearized reading' (duration: 277.707216ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:46.074903Z","caller":"traceutil/trace.go:171","msg":"trace[1881927326] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"1.111134633s","start":"2026-02-26T21:39:44.963717Z","end":"2026-02-26T21:39:46.074852Z","steps":["trace[1881927326] 'process raft request' (duration: 163.975286ms)","trace[1881927326] 'compare' (duration: 946.555593ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:39:46.07505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:44.963663Z","time spent":"1.111307296s","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:39:46.611174Z","caller":"traceutil/trace.go:171","msg":"trace[829920907] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"478.490598ms","start":"2026-02-26T21:39:46.132661Z","end":"2026-02-26T21:39:46.611152Z","steps":["trace[829920907] 'process raft request' (duration: 478.353575ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:39:46.611308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:39:46.132612Z","time spent":"478.627271ms","remote":"127.0.0.1:60890","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-02-26T21:39:57.165592Z","caller":"traceutil/trace.go:171","msg":"trace[591365222] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"149.107876ms","start":"2026-02-26T21:39:57.016462Z","end":"2026-02-26T21:39:57.16557Z","steps":["trace[591365222] 'process raft request' (duration: 148.955342ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:57.187934Z","caller":"traceutil/trace.go:171","msg":"trace[1044492944] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"170.48519ms","start":"2026-02-26T21:39:57.017428Z","end":"2026-02-26T21:39:57.187913Z","steps":["trace[1044492944] 'process raft request' (duration: 170.316056ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:57.188128Z","caller":"traceutil/trace.go:171","msg":"trace[977060135] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"170.564951ms","start":"2026-02-26T21:39:57.01755Z","end":"2026-02-26T21:39:57.188115Z","steps":["trace[977060135] 'process raft request' (duration: 170.326746ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:57.858062Z","caller":"traceutil/trace.go:171","msg":"trace[1280070956] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"113.143558ms","start":"2026-02-26T21:39:57.744883Z","end":"2026-02-26T21:39:57.858026Z","steps":["trace[1280070956] 'process raft request' (duration: 97.502522ms)","trace[1280070956] 'compare' (duration: 15.34351ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:39:57.858117Z","caller":"traceutil/trace.go:171","msg":"trace[1346764884] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"113.18938ms","start":"2026-02-26T21:39:57.744899Z","end":"2026-02-26T21:39:57.858088Z","steps":["trace[1346764884] 'process raft request' (duration: 112.952125ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:58.017903Z","caller":"traceutil/trace.go:171","msg":"trace[330923495] transaction","detail":"{read_only:false; response_revision:843; number_of_response:1; }","duration":"128.705943ms","start":"2026-02-26T21:39:57.889173Z","end":"2026-02-26T21:39:58.017879Z","steps":["trace[330923495] 'process raft request' (duration: 104.424695ms)","trace[330923495] 'compare' (duration: 24.145175ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:39:58.027381Z","caller":"traceutil/trace.go:171","msg":"trace[593319268] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"137.273084ms","start":"2026-02-26T21:39:57.890091Z","end":"2026-02-26T21:39:58.027365Z","steps":["trace[593319268] 'process raft request' (duration: 137.232933ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:58.027515Z","caller":"traceutil/trace.go:171","msg":"trace[2053597230] transaction","detail":"{read_only:false; response_revision:844; number_of_response:1; }","duration":"137.701743ms","start":"2026-02-26T21:39:57.889756Z","end":"2026-02-26T21:39:58.027458Z","steps":["trace[2053597230] 'process raft request' (duration: 137.498038ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:58.31144Z","caller":"traceutil/trace.go:171","msg":"trace[465959083] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"101.420308ms","start":"2026-02-26T21:39:58.209999Z","end":"2026-02-26T21:39:58.31142Z","steps":["trace[465959083] 'process raft request' (duration: 101.384347ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:58.311528Z","caller":"traceutil/trace.go:171","msg":"trace[1532146285] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"101.829367ms","start":"2026-02-26T21:39:58.209656Z","end":"2026-02-26T21:39:58.311486Z","steps":["trace[1532146285] 'process raft request' (duration: 101.666734ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:39:59.033774Z","caller":"traceutil/trace.go:171","msg":"trace[1438213026] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"111.948172ms","start":"2026-02-26T21:39:58.921807Z","end":"2026-02-26T21:39:59.033755Z","steps":["trace[1438213026] 'process raft request' (duration: 111.789048ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:00.88864Z","caller":"traceutil/trace.go:171","msg":"trace[57856540] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"126.120257ms","start":"2026-02-26T21:40:00.76249Z","end":"2026-02-26T21:40:00.88861Z","steps":["trace[57856540] 'process raft request' (duration: 125.859871ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:01.402223Z","caller":"traceutil/trace.go:171","msg":"trace[2091583042] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"146.479498ms","start":"2026-02-26T21:40:01.255714Z","end":"2026-02-26T21:40:01.402194Z","steps":["trace[2091583042] 'process raft request' (duration: 48.346242ms)","trace[2091583042] 'compare' (duration: 98.016973ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:40:03.299584Z","caller":"traceutil/trace.go:171","msg":"trace[313985227] linearizableReadLoop","detail":"{readStateIndex:936; appliedIndex:935; }","duration":"149.28771ms","start":"2026-02-26T21:40:03.150268Z","end":"2026-02-26T21:40:03.299555Z","steps":["trace[313985227] 'read index received' (duration: 148.958902ms)","trace[313985227] 'applied index is now lower than readState.Index' (duration: 326.988µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:40:03.299633Z","caller":"traceutil/trace.go:171","msg":"trace[1398868071] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"399.917017ms","start":"2026-02-26T21:40:02.899678Z","end":"2026-02-26T21:40:03.299595Z","steps":["trace[1398868071] 'process raft request' (duration: 399.673661ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:03.299872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:02.899656Z","time spent":"400.055229ms","remote":"127.0.0.1:60890","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-02-26T21:40:03.299938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.639137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T21:40:03.300067Z","caller":"traceutil/trace.go:171","msg":"trace[770071924] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:902; }","duration":"149.838722ms","start":"2026-02-26T21:40:03.150207Z","end":"2026-02-26T21:40:03.300045Z","steps":["trace[770071924] 'agreement among raft nodes before linearized reading' (duration: 149.481044ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:05.508233Z","caller":"traceutil/trace.go:171","msg":"trace[533419587] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"200.681012ms","start":"2026-02-26T21:40:05.307535Z","end":"2026-02-26T21:40:05.508216Z","steps":["trace[533419587] 'process raft request' (duration: 200.56503ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:05.508308Z","caller":"traceutil/trace.go:171","msg":"trace[1223627322] linearizableReadLoop","detail":"{readStateIndex:946; appliedIndex:946; }","duration":"116.549811ms","start":"2026-02-26T21:40:05.391731Z","end":"2026-02-26T21:40:05.508281Z","steps":["trace[1223627322] 'read index received' (duration: 116.536041ms)","trace[1223627322] 'applied index is now lower than readState.Index' (duration: 11.37µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:40:05.508563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.357306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-02-26T21:40:05.508574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.821017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T21:40:05.508591Z","caller":"traceutil/trace.go:171","msg":"trace[1982601525] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:912; }","duration":"116.427708ms","start":"2026-02-26T21:40:05.392155Z","end":"2026-02-26T21:40:05.508583Z","steps":["trace[1982601525] 'agreement among raft nodes before linearized reading' (duration: 116.333186ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:05.508606Z","caller":"traceutil/trace.go:171","msg":"trace[1496187987] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:912; }","duration":"116.895019ms","start":"2026-02-26T21:40:05.391702Z","end":"2026-02-26T21:40:05.508597Z","steps":["trace[1496187987] 'agreement among raft nodes before linearized reading' (duration: 116.744216ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:05.508728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.684841ms","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-02-26T21:40:05.508747Z","caller":"traceutil/trace.go:171","msg":"trace[1538787004] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:912; }","duration":"115.722173ms","start":"2026-02-26T21:40:05.39302Z","end":"2026-02-26T21:40:05.508743Z","steps":["trace[1538787004] 'agreement among raft nodes before linearized reading' (duration: 115.675611ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:07.296815Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810625527845589,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T21:40:07.564452Z","caller":"traceutil/trace.go:171","msg":"trace[1988312018] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"927.129938ms","start":"2026-02-26T21:40:06.637291Z","end":"2026-02-26T21:40:07.564421Z","steps":["trace[1988312018] 'process raft request' (duration: 926.932403ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:07.564842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:06.637264Z","time spent":"927.352633ms","remote":"127.0.0.1:60890","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-02-26T21:40:08.796302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000149957s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-02-26T21:40:08.79637Z","caller":"traceutil/trace.go:171","msg":"trace[1184358376] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00028358s","start":"2026-02-26T21:40:06.796072Z","end":"2026-02-26T21:40:08.796355Z","steps":["trace[1184358376] 'agreement among raft nodes before linearized reading' (duration: 2.000173778s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:08.796407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:06.796056Z","time spent":"2.000346332s","remote":"127.0.0.1:60674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-26T21:40:09.008549Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.444298277s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-26T21:40:09.008584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.228168501s","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-02-26T21:40:09.008721Z","caller":"traceutil/trace.go:171","msg":"trace[1874724361] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:917; }","duration":"1.228313665s","start":"2026-02-26T21:40:07.780391Z","end":"2026-02-26T21:40:09.008705Z","steps":["trace[1874724361] 'range keys from in-memory index tree' (duration: 1.228136701s)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:09.069656Z","caller":"traceutil/trace.go:171","msg":"trace[1145323645] linearizableReadLoop","detail":"{readStateIndex:952; appliedIndex:950; }","duration":"2.273524849s","start":"2026-02-26T21:40:06.796107Z","end":"2026-02-26T21:40:09.069631Z","steps":["trace[1145323645] 'read index received' (duration: 768.126527ms)","trace[1145323645] 'applied index is now lower than readState.Index' (duration: 1.505396802s)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:40:09.06983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.174064808s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:40:09.06987Z","caller":"traceutil/trace.go:171","msg":"trace[1433648209] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:917; }","duration":"2.17415076s","start":"2026-02-26T21:40:06.895709Z","end":"2026-02-26T21:40:09.069859Z","steps":["trace[1433648209] 'agreement among raft nodes before linearized reading' (duration: 2.174064418s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:09.06991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:06.895693Z","time spent":"2.174207041s","remote":"127.0.0.1:60932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-26T21:40:09.069958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.49697889s","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-02-26T21:40:09.070039Z","caller":"traceutil/trace.go:171","msg":"trace[100097602] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:917; }","duration":"1.497085442s","start":"2026-02-26T21:40:07.572934Z","end":"2026-02-26T21:40:09.07002Z","steps":["trace[100097602] 'agreement among raft nodes before linearized reading' (duration: 1.496866737s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:09.070083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:07.572919Z","time spent":"1.497155914s","remote":"127.0.0.1:60890","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-02-26T21:40:09.070196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.497974333s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-02-26T21:40:09.070233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.559071717s","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-02-26T21:40:09.070264Z","caller":"traceutil/trace.go:171","msg":"trace[586430070] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:917; }","duration":"1.559139439s","start":"2026-02-26T21:40:07.511115Z","end":"2026-02-26T21:40:09.070255Z","steps":["trace[586430070] 'agreement among raft nodes before linearized reading' (duration: 1.559029677s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:09.070257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.002492311s","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-02-26T21:40:09.070264Z","caller":"traceutil/trace.go:171","msg":"trace[1929321963] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:917; }","duration":"1.498076325s","start":"2026-02-26T21:40:07.572168Z","end":"2026-02-26T21:40:09.070244Z","steps":["trace[1929321963] 'agreement among raft nodes before linearized reading' (duration: 1.497938722s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:09.070286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.115806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T21:40:09.070304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:07.511099Z","time spent":"1.55919878s","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-26T21:40:09.070313Z","caller":"traceutil/trace.go:171","msg":"trace[1678894639] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:917; }","duration":"2.002594963s","start":"2026-02-26T21:40:07.067699Z","end":"2026-02-26T21:40:09.070294Z","steps":["trace[1678894639] 'agreement among raft nodes before linearized reading' (duration: 2.002484711s)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:09.070317Z","caller":"traceutil/trace.go:171","msg":"trace[1251568410] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:917; }","duration":"273.182847ms","start":"2026-02-26T21:40:08.797124Z","end":"2026-02-26T21:40:09.070307Z","steps":["trace[1251568410] 'agreement among raft nodes before linearized reading' (duration: 273.138366ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:09.070321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:07.572146Z","time spent":"1.498162416s","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T21:40:09.070338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:07.06768Z","time spent":"2.002652645s","remote":"127.0.0.1:60890","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-02-26T21:40:09.070059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.544959805s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-26T21:40:09.070417Z","caller":"traceutil/trace.go:171","msg":"trace[1565939721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:917; }","duration":"1.545349475s","start":"2026-02-26T21:40:07.525053Z","end":"2026-02-26T21:40:09.070403Z","steps":["trace[1565939721] 'agreement among raft nodes before linearized reading' (duration: 1.544836263s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:09.070473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.496961829s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-02-26T21:40:09.070466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:07.525043Z","time spent":"1.545408856s","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-26T21:40:09.070487Z","caller":"traceutil/trace.go:171","msg":"trace[865084697] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:917; }","duration":"1.496975139s","start":"2026-02-26T21:40:07.573507Z","end":"2026-02-26T21:40:09.070482Z","steps":["trace[865084697] 'agreement among raft nodes before linearized reading' (duration: 1.496906368s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:09.070499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:07.573478Z","time spent":"1.497018481s","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-26T21:40:15.606904Z","caller":"traceutil/trace.go:171","msg":"trace[29396174] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"399.87075ms","start":"2026-02-26T21:40:15.207013Z","end":"2026-02-26T21:40:15.606883Z","steps":["trace[29396174] 'process raft request' (duration: 383.889125ms)","trace[29396174] 'compare' (duration: 15.686189ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:40:15.607016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:15.206999Z","time spent":"399.959142ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:40:15.607102Z","caller":"traceutil/trace.go:171","msg":"trace[968365041] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"399.789679ms","start":"2026-02-26T21:40:15.207283Z","end":"2026-02-26T21:40:15.607073Z","steps":["trace[968365041] 'process raft request' (duration: 399.705977ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:15.607123Z","caller":"traceutil/trace.go:171","msg":"trace[1808874227] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"400.015963ms","start":"2026-02-26T21:40:15.207086Z","end":"2026-02-26T21:40:15.607102Z","steps":["trace[1808874227] 'process raft request' (duration: 399.761247ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:15.607217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:15.207264Z","time spent":"399.88851ms","remote":"127.0.0.1:60890","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-02-26T21:40:15.607246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:15.207078Z","time spent":"400.094005ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:40:26.115268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.538661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T21:40:26.115343Z","caller":"traceutil/trace.go:171","msg":"trace[1175484216] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:964; }","duration":"607.655384ms","start":"2026-02-26T21:40:25.507669Z","end":"2026-02-26T21:40:26.115324Z","steps":["trace[1175484216] 'range keys from in-memory index tree' (duration: 607.396258ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:26.115392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:25.507652Z","time spent":"607.731475ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T21:40:26.283358Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810625527845725,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T21:40:26.410371Z","caller":"traceutil/trace.go:171","msg":"trace[767085613] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"771.585587ms","start":"2026-02-26T21:40:25.638745Z","end":"2026-02-26T21:40:26.410331Z","steps":["trace[767085613] 'process raft request' (duration: 771.408733ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:26.41052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:25.638711Z","time spent":"771.72891ms","remote":"127.0.0.1:60810","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5634,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:40:27.03003Z","caller":"traceutil/trace.go:171","msg":"trace[1549449185] linearizableReadLoop","detail":"{readStateIndex:1004; appliedIndex:1002; }","duration":"1.247029813s","start":"2026-02-26T21:40:25.78296Z","end":"2026-02-26T21:40:27.02999Z","steps":["trace[1549449185] 'read index received' (duration: 627.265422ms)","trace[1549449185] 'applied index is now lower than readState.Index' (duration: 619.763191ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:40:27.030105Z","caller":"traceutil/trace.go:171","msg":"trace[1487541165] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"910.858307ms","start":"2026-02-26T21:40:26.11922Z","end":"2026-02-26T21:40:27.030078Z","steps":["trace[1487541165] 'process raft request' (duration: 907.824488ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:27.030268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:26.119203Z","time spent":"910.977549ms","remote":"127.0.0.1:60890","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-02-26T21:40:27.032467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.249480859s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-26T21:40:27.032565Z","caller":"traceutil/trace.go:171","msg":"trace[592371216] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:966; }","duration":"1.249628212s","start":"2026-02-26T21:40:25.782908Z","end":"2026-02-26T21:40:27.032536Z","steps":["trace[592371216] 'agreement among raft nodes before linearized reading' (duration: 1.247215317s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:27.03261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:25.782894Z","time spent":"1.249706623s","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T21:40:27.032815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.243120054s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T21:40:27.032876Z","caller":"traceutil/trace.go:171","msg":"trace[589346956] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:966; }","duration":"1.243241626s","start":"2026-02-26T21:40:25.789616Z","end":"2026-02-26T21:40:27.032857Z","steps":["trace[589346956] 'agreement among raft nodes before linearized reading' (duration: 1.243126284s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:27.03292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:25.789536Z","time spent":"1.243372589s","remote":"127.0.0.1:32906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":3,"response size":30,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"warn","ts":"2026-02-26T21:40:27.032978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.221148552s","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-02-26T21:40:27.033042Z","caller":"traceutil/trace.go:171","msg":"trace[331414387] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:966; }","duration":"1.221230583s","start":"2026-02-26T21:40:25.811795Z","end":"2026-02-26T21:40:27.033026Z","steps":["trace[331414387] 'agreement among raft nodes before linearized reading' (duration: 1.22110991s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:27.033101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:25.811782Z","time spent":"1.221304005s","remote":"127.0.0.1:60890","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-02-26T21:40:27.033184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.221710045s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-02-26T21:40:27.033302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.075927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T21:40:27.033345Z","caller":"traceutil/trace.go:171","msg":"trace[1981445325] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:966; }","duration":"595.164249ms","start":"2026-02-26T21:40:26.438168Z","end":"2026-02-26T21:40:27.033332Z","steps":["trace[1981445325] 'agreement among raft nodes before linearized reading' (duration: 595.087727ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:27.033379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:26.438146Z","time spent":"595.22438ms","remote":"127.0.0.1:32838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-02-26T21:40:27.033544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"984.813996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T21:40:27.033577Z","caller":"traceutil/trace.go:171","msg":"trace[1124627052] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:966; }","duration":"984.913638ms","start":"2026-02-26T21:40:26.048656Z","end":"2026-02-26T21:40:27.033569Z","steps":["trace[1124627052] 'agreement among raft nodes before linearized reading' (duration: 984.861946ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:27.033604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:26.048637Z","time spent":"984.960029ms","remote":"127.0.0.1:60816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":4,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"info","ts":"2026-02-26T21:40:27.033595Z","caller":"traceutil/trace.go:171","msg":"trace[1703142597] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:966; }","duration":"1.221752895s","start":"2026-02-26T21:40:25.811457Z","end":"2026-02-26T21:40:27.03321Z","steps":["trace[1703142597] 'agreement among raft nodes before linearized reading' (duration: 1.221633833s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:27.033686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:25.811438Z","time spent":"1.222228996s","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-26T21:40:27.033903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.238277093s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:40:27.033943Z","caller":"traceutil/trace.go:171","msg":"trace[1725948273] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:966; }","duration":"1.238324084s","start":"2026-02-26T21:40:25.795606Z","end":"2026-02-26T21:40:27.03393Z","steps":["trace[1725948273] 'agreement among raft nodes before linearized reading' (duration: 1.238256752s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:27.033977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:25.7956Z","time spent":"1.238368135s","remote":"127.0.0.1:60674","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-02-26T21:40:29.66685Z","caller":"traceutil/trace.go:171","msg":"trace[11564657] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"139.144497ms","start":"2026-02-26T21:40:29.527681Z","end":"2026-02-26T21:40:29.666826Z","steps":["trace[11564657] 'process raft request' (duration: 138.916132ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:31.319114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.694646ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T21:40:31.319314Z","caller":"traceutil/trace.go:171","msg":"trace[1885161668] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"237.36953ms","start":"2026-02-26T21:40:31.081929Z","end":"2026-02-26T21:40:31.319298Z","steps":["trace[1885161668] 'process raft request' (duration: 237.335119ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:31.319623Z","caller":"traceutil/trace.go:171","msg":"trace[1447173545] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"238.563557ms","start":"2026-02-26T21:40:31.080986Z","end":"2026-02-26T21:40:31.31955Z","steps":["trace[1447173545] 'process raft request' (duration: 238.2345ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:31.319901Z","caller":"traceutil/trace.go:171","msg":"trace[1275134836] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"240.194564ms","start":"2026-02-26T21:40:31.079659Z","end":"2026-02-26T21:40:31.319854Z","steps":["trace[1275134836] 'process raft request' (duration: 40.677119ms)","trace[1275134836] 'compare' (duration: 198.555023ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:40:32.06177Z","caller":"traceutil/trace.go:171","msg":"trace[1959326444] linearizableReadLoop","detail":"{readStateIndex:1043; appliedIndex:1042; }","duration":"264.606332ms","start":"2026-02-26T21:40:31.797131Z","end":"2026-02-26T21:40:32.061737Z","steps":["trace[1959326444] 'read index received' (duration: 264.391917ms)","trace[1959326444] 'applied index is now lower than readState.Index' (duration: 212.975µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:40:32.061922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.773446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:40:32.061963Z","caller":"traceutil/trace.go:171","msg":"trace[1366931205] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1002; }","duration":"264.834947ms","start":"2026-02-26T21:40:31.797111Z","end":"2026-02-26T21:40:32.061946Z","steps":["trace[1366931205] 'agreement among raft nodes before linearized reading' (duration: 264.752716ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:32.061953Z","caller":"traceutil/trace.go:171","msg":"trace[541425086] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"327.18188ms","start":"2026-02-26T21:40:31.734724Z","end":"2026-02-26T21:40:32.061906Z","steps":["trace[541425086] 'process raft request' (duration: 326.833203ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:32.063311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:31.734697Z","time spent":"327.363585ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:40:33.519481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.232575ms","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-02-26T21:40:33.519591Z","caller":"traceutil/trace.go:171","msg":"trace[221945767] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1002; }","duration":"194.402609ms","start":"2026-02-26T21:40:33.325161Z","end":"2026-02-26T21:40:33.519563Z","steps":["trace[221945767] 'range keys from in-memory index tree' (duration: 194.03471ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:33.519635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.160363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-02-26T21:40:33.519513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.374122ms","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-02-26T21:40:33.519727Z","caller":"traceutil/trace.go:171","msg":"trace[1380548223] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1002; }","duration":"194.338137ms","start":"2026-02-26T21:40:33.325368Z","end":"2026-02-26T21:40:33.519706Z","steps":["trace[1380548223] 'range keys from in-memory index tree' (duration: 193.861886ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:33.519748Z","caller":"traceutil/trace.go:171","msg":"trace[1457292146] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1002; }","duration":"178.596498ms","start":"2026-02-26T21:40:33.341122Z","end":"2026-02-26T21:40:33.519718Z","steps":["trace[1457292146] 'range keys from in-memory index tree' (duration: 178.210249ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:33.519921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.465465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:40:33.520065Z","caller":"traceutil/trace.go:171","msg":"trace[1199411693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1002; }","duration":"577.650219ms","start":"2026-02-26T21:40:32.942402Z","end":"2026-02-26T21:40:33.520052Z","steps":["trace[1199411693] 'range keys from in-memory index tree' (duration: 577.354582ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:33.520109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:32.942378Z","time spent":"577.72051ms","remote":"127.0.0.1:60674","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-02-26T21:40:33.520157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.340534ms","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-02-26T21:40:33.520199Z","caller":"traceutil/trace.go:171","msg":"trace[1139231861] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1002; }","duration":"440.418275ms","start":"2026-02-26T21:40:33.07977Z","end":"2026-02-26T21:40:33.520189Z","steps":["trace[1139231861] 'range keys from in-memory index tree' (duration: 440.223351ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:33.520229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:33.07976Z","time spent":"440.460857ms","remote":"127.0.0.1:60890","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":"info","ts":"2026-02-26T21:40:33.954199Z","caller":"traceutil/trace.go:171","msg":"trace[1240601573] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"428.625736ms","start":"2026-02-26T21:40:33.525541Z","end":"2026-02-26T21:40:33.954166Z","steps":["trace[1240601573] 'process raft request' (duration: 428.3783ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:33.954396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:33.525508Z","time spent":"428.7866ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:40:34.571538Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810625527845803,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T21:40:34.963581Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.009643972s","expected-duration":"1s"} {"level":"info","ts":"2026-02-26T21:40:35.059321Z","caller":"traceutil/trace.go:171","msg":"trace[235110550] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"1.532894559s","start":"2026-02-26T21:40:33.526391Z","end":"2026-02-26T21:40:35.059285Z","steps":["trace[235110550] 'process raft request' (duration: 1.532841298s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:35.059508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:33.526367Z","time spent":"1.533043123s","remote":"127.0.0.1:60890","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-02-26T21:40:35.059737Z","caller":"traceutil/trace.go:171","msg":"trace[1211719472] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"1.533514673s","start":"2026-02-26T21:40:33.526209Z","end":"2026-02-26T21:40:35.059723Z","steps":["trace[1211719472] 'process raft request' (duration: 1.437628864s)","trace[1211719472] 'compare' (duration: 95.172143ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:40:35.059807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:33.526196Z","time spent":"1.533577465s","remote":"127.0.0.1:60890","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-02-26T21:40:35.059888Z","caller":"traceutil/trace.go:171","msg":"trace[738053978] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"1.533515074s","start":"2026-02-26T21:40:33.526362Z","end":"2026-02-26T21:40:35.059877Z","steps":["trace[738053978] 'process raft request' (duration: 1.532765767s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:35.059931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:33.526336Z","time spent":"1.533571565s","remote":"127.0.0.1:60890","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-02-26T21:40:35.279391Z","caller":"traceutil/trace.go:171","msg":"trace[1392228371] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"317.370836ms","start":"2026-02-26T21:40:34.961989Z","end":"2026-02-26T21:40:35.27936Z","steps":["trace[1392228371] 'process raft request' (duration: 317.199432ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:35.279395Z","caller":"traceutil/trace.go:171","msg":"trace[1121870936] linearizableReadLoop","detail":"{readStateIndex:1048; appliedIndex:1044; }","duration":"1.208238087s","start":"2026-02-26T21:40:34.07112Z","end":"2026-02-26T21:40:35.279358Z","steps":["trace[1121870936] 'read index received' (duration: 892.734303ms)","trace[1121870936] 'applied index is now lower than readState.Index' (duration: 315.501854ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:40:35.27931Z","caller":"traceutil/trace.go:171","msg":"trace[1504757287] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"871.765754ms","start":"2026-02-26T21:40:34.407509Z","end":"2026-02-26T21:40:35.279275Z","steps":["trace[1504757287] 'process raft request' (duration: 820.019333ms)","trace[1504757287] 'compare' (duration: 51.063476ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:40:35.27956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:34.961962Z","time spent":"317.50598ms","remote":"127.0.0.1:60732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":888,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:40:35.279645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"999.992772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T21:40:35.279681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.208559804s","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-02-26T21:40:35.279704Z","caller":"traceutil/trace.go:171","msg":"trace[1069067043] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1008; }","duration":"1.000136396s","start":"2026-02-26T21:40:34.279546Z","end":"2026-02-26T21:40:35.279683Z","steps":["trace[1069067043] 'agreement among raft nodes before linearized reading' (duration: 1.000008893s)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:35.279739Z","caller":"traceutil/trace.go:171","msg":"trace[2065110997] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1008; }","duration":"1.208677077s","start":"2026-02-26T21:40:34.071045Z","end":"2026-02-26T21:40:35.279722Z","steps":["trace[2065110997] 'agreement among raft nodes before linearized reading' (duration: 1.208421591s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:35.279757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:34.279524Z","time spent":"1.000217627s","remote":"127.0.0.1:50748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-02-26T21:40:35.279787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:34.06792Z","time spent":"1.21185585s","remote":"127.0.0.1:60890","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-02-26T21:40:35.279848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.83496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:40:35.279901Z","caller":"traceutil/trace.go:171","msg":"trace[744392413] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1008; }","duration":"484.926512ms","start":"2026-02-26T21:40:34.794959Z","end":"2026-02-26T21:40:35.279885Z","steps":["trace[744392413] 'agreement among raft nodes before linearized reading' (duration: 484.83487ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:35.279939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:34.794938Z","time spent":"484.992373ms","remote":"127.0.0.1:60674","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-02-26T21:40:35.279713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:34.407479Z","time spent":"872.022171ms","remote":"127.0.0.1:60890","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-02-26T21:40:36.299266Z","caller":"traceutil/trace.go:171","msg":"trace[1121644031] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"119.52685ms","start":"2026-02-26T21:40:36.179649Z","end":"2026-02-26T21:40:36.299176Z","steps":["trace[1121644031] 'process raft request' (duration: 119.325705ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:37.312712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.454127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:40:37.312806Z","caller":"traceutil/trace.go:171","msg":"trace[2031829442] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1011; }","duration":"507.60582ms","start":"2026-02-26T21:40:36.805178Z","end":"2026-02-26T21:40:37.312784Z","steps":["trace[2031829442] 'range keys from in-memory index tree' (duration: 507.345984ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:37.312846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:36.805156Z","time spent":"507.681481ms","remote":"127.0.0.1:60668","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-02-26T21:40:37.565492Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810625527845819,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-26T21:40:38.045931Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.077778638s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-26T21:40:38.415786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.472186ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-26T21:40:38.58123Z","caller":"traceutil/trace.go:171","msg":"trace[846475562] linearizableReadLoop","detail":"{readStateIndex:1054; appliedIndex:1052; }","duration":"1.516662628s","start":"2026-02-26T21:40:37.064543Z","end":"2026-02-26T21:40:38.581206Z","steps":["trace[846475562] 'read index received' (duration: 981.708934ms)","trace[846475562] 'applied index is now lower than readState.Index' (duration: 534.953064ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:40:38.581348Z","caller":"traceutil/trace.go:171","msg":"trace[1085857011] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"695.207633ms","start":"2026-02-26T21:40:37.886132Z","end":"2026-02-26T21:40:38.58134Z","steps":["trace[1085857011] 'process raft request' (duration: 695.025909ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:38.581466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:37.886085Z","time spent":"695.287775ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:40:38.581547Z","caller":"traceutil/trace.go:171","msg":"trace[1001323647] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"1.209511306s","start":"2026-02-26T21:40:37.371984Z","end":"2026-02-26T21:40:38.581495Z","steps":["trace[1001323647] 'process raft request' (duration: 1.208986714s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:38.581716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:37.371957Z","time spent":"1.20967666s","remote":"127.0.0.1:60732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":784,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:40:38.581931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.517357974s","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-02-26T21:40:38.582046Z","caller":"traceutil/trace.go:171","msg":"trace[270125216] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1013; }","duration":"1.517521227s","start":"2026-02-26T21:40:37.064496Z","end":"2026-02-26T21:40:38.582017Z","steps":["trace[270125216] 'agreement among raft nodes before linearized reading' (duration: 1.517068047s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:38.582099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:37.064459Z","time spent":"1.51763043s","remote":"127.0.0.1:60890","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-02-26T21:40:38.582205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.517604399s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-26T21:40:38.58224Z","caller":"traceutil/trace.go:171","msg":"trace[1130048114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1013; }","duration":"1.517677731s","start":"2026-02-26T21:40:37.06455Z","end":"2026-02-26T21:40:38.582228Z","steps":["trace[1130048114] 'agreement among raft nodes before linearized reading' (duration: 1.517556798s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:38.582263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:37.064528Z","time spent":"1.517729543s","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T21:40:38.582249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.779439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:40:38.582299Z","caller":"traceutil/trace.go:171","msg":"trace[539721174] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1013; }","duration":"784.905462ms","start":"2026-02-26T21:40:37.79738Z","end":"2026-02-26T21:40:38.582285Z","steps":["trace[539721174] 'agreement among raft nodes before linearized reading' (duration: 784.790139ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:38.582366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.200668663s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-02-26T21:40:38.582361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:37.797359Z","time spent":"784.992883ms","remote":"127.0.0.1:60674","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-02-26T21:40:38.582385Z","caller":"traceutil/trace.go:171","msg":"trace[2016478304] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1013; }","duration":"1.200725295s","start":"2026-02-26T21:40:37.381653Z","end":"2026-02-26T21:40:38.582378Z","steps":["trace[2016478304] 'agreement among raft nodes before linearized reading' (duration: 1.200665193s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:38.582415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:37.381632Z","time spent":"1.200777736s","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-26T21:40:38.582506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.501071032s","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-02-26T21:40:38.582519Z","caller":"traceutil/trace.go:171","msg":"trace[141448554] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1013; }","duration":"1.501083863s","start":"2026-02-26T21:40:37.081431Z","end":"2026-02-26T21:40:38.582515Z","steps":["trace[141448554] 'agreement among raft nodes before linearized reading' (duration: 1.501041852s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:38.582531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:37.081394Z","time spent":"1.501134044s","remote":"127.0.0.1:60890","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-02-26T21:40:38.582567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.660453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-26T21:40:38.582589Z","caller":"traceutil/trace.go:171","msg":"trace[1531642454] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1013; }","duration":"564.730944ms","start":"2026-02-26T21:40:38.017851Z","end":"2026-02-26T21:40:38.582582Z","steps":["trace[1531642454] 'agreement among raft nodes before linearized reading' (duration: 564.640612ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:38.582604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:38.017826Z","time spent":"564.775415ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-26T21:40:38.883475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.263868ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T21:40:38.883607Z","caller":"traceutil/trace.go:171","msg":"trace[624578085] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"297.906952ms","start":"2026-02-26T21:40:38.585678Z","end":"2026-02-26T21:40:38.883585Z","steps":["trace[624578085] 'process raft request' (duration: 148.435129ms)","trace[624578085] 'compare' (duration: 149.117045ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:40:39.26187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.163473ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T21:40:39.262317Z","caller":"traceutil/trace.go:171","msg":"trace[991424749] linearizableReadLoop","detail":"{readStateIndex:1061; appliedIndex:1055; }","duration":"607.391578ms","start":"2026-02-26T21:40:38.654893Z","end":"2026-02-26T21:40:39.262285Z","steps":["trace[991424749] 'read index received' (duration: 79.335472ms)","trace[991424749] 'applied index is now lower than readState.Index' (duration: 528.052356ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:40:39.262485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.570782ms","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-02-26T21:40:39.262521Z","caller":"traceutil/trace.go:171","msg":"trace[1599550632] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1019; }","duration":"607.680494ms","start":"2026-02-26T21:40:38.654827Z","end":"2026-02-26T21:40:39.262507Z","steps":["trace[1599550632] 'agreement among raft nodes before linearized reading' (duration: 607.547721ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:39.26256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:38.6548Z","time spent":"607.750006ms","remote":"127.0.0.1:32888","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":"info","ts":"2026-02-26T21:40:39.262923Z","caller":"traceutil/trace.go:171","msg":"trace[1610995052] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"676.489575ms","start":"2026-02-26T21:40:38.586418Z","end":"2026-02-26T21:40:39.262908Z","steps":["trace[1610995052] 'process raft request' (duration: 541.181176ms)","trace[1610995052] 'compare' (duration: 133.949368ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:40:39.262989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:38.586401Z","time spent":"676.552017ms","remote":"127.0.0.1:60890","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-02-26T21:40:39.263261Z","caller":"traceutil/trace.go:171","msg":"trace[1819893233] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"676.646679ms","start":"2026-02-26T21:40:38.586484Z","end":"2026-02-26T21:40:39.263131Z","steps":["trace[1819893233] 'process raft request' (duration: 675.512013ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:39.263336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:38.586476Z","time spent":"676.817373ms","remote":"127.0.0.1:60890","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-02-26T21:40:39.26353Z","caller":"traceutil/trace.go:171","msg":"trace[318544313] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"676.897464ms","start":"2026-02-26T21:40:38.586621Z","end":"2026-02-26T21:40:39.263518Z","steps":["trace[318544313] 'process raft request' (duration: 675.452211ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:39.263593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:38.586616Z","time spent":"676.940566ms","remote":"127.0.0.1:60890","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-02-26T21:40:39.263795Z","caller":"traceutil/trace.go:171","msg":"trace[1106472341] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"676.863964ms","start":"2026-02-26T21:40:38.58692Z","end":"2026-02-26T21:40:39.263784Z","steps":["trace[1106472341] 'process raft request' (duration: 675.236657ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:39.263888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:38.586916Z","time spent":"676.903475ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:40:39.264118Z","caller":"traceutil/trace.go:171","msg":"trace[756066023] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"677.009338ms","start":"2026-02-26T21:40:38.587097Z","end":"2026-02-26T21:40:39.264106Z","steps":["trace[756066023] 'process raft request' (duration: 675.122705ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:39.264179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:38.587092Z","time spent":"677.054218ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:40:41.210276Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810625527845834,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T21:40:41.349229Z","caller":"traceutil/trace.go:171","msg":"trace[292654586] linearizableReadLoop","detail":"{readStateIndex:1063; appliedIndex:1062; }","duration":"639.279917ms","start":"2026-02-26T21:40:40.709909Z","end":"2026-02-26T21:40:41.349189Z","steps":["trace[292654586] 'read index received' (duration: 557.006738ms)","trace[292654586] 'applied index is now lower than readState.Index' (duration: 82.271109ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:40:41.34942Z","caller":"traceutil/trace.go:171","msg":"trace[1842308364] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"800.876636ms","start":"2026-02-26T21:40:40.548521Z","end":"2026-02-26T21:40:41.349398Z","steps":["trace[1842308364] 'process raft request' (duration: 718.458475ms)","trace[1842308364] 'compare' (duration: 81.94043ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:40:41.349565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:40.548493Z","time spent":"800.974768ms","remote":"127.0.0.1:60732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":786,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:40:41.349897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.663927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:40:41.350038Z","caller":"traceutil/trace.go:171","msg":"trace[1062557601] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1021; }","duration":"435.849621ms","start":"2026-02-26T21:40:40.914166Z","end":"2026-02-26T21:40:41.350015Z","steps":["trace[1062557601] 'agreement among raft nodes before linearized reading' (duration: 435.611776ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:41.350107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:40.914147Z","time spent":"435.946674ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-26T21:40:41.35015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.242498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:40:41.350214Z","caller":"traceutil/trace.go:171","msg":"trace[1456452409] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1021; }","duration":"640.345131ms","start":"2026-02-26T21:40:40.709854Z","end":"2026-02-26T21:40:41.350199Z","steps":["trace[1456452409] 'agreement among raft nodes before linearized reading' (duration: 640.250048ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:41.350264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:40.709829Z","time spent":"640.422923ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-26T21:40:41.747651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.045453ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T21:40:41.747887Z","caller":"traceutil/trace.go:171","msg":"trace[1562307541] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"391.382416ms","start":"2026-02-26T21:40:41.356482Z","end":"2026-02-26T21:40:41.747864Z","steps":["trace[1562307541] 'process raft request' (duration: 391.289504ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:41.747879Z","caller":"traceutil/trace.go:171","msg":"trace[717496132] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"391.464637ms","start":"2026-02-26T21:40:41.356374Z","end":"2026-02-26T21:40:41.747838Z","steps":["trace[717496132] 'process raft request' (duration: 267.124418ms)","trace[717496132] 'compare' (duration: 123.90835ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:40:41.747964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:41.356455Z","time spent":"391.466637ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:40:41.748074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:41.356353Z","time spent":"391.602111ms","remote":"127.0.0.1:60890","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-02-26T21:40:41.748163Z","caller":"traceutil/trace.go:171","msg":"trace[1210568009] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"390.617449ms","start":"2026-02-26T21:40:41.357535Z","end":"2026-02-26T21:40:41.748153Z","steps":["trace[1210568009] 'process raft request' (duration: 390.290841ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:41.748226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:41.357523Z","time spent":"390.67381ms","remote":"127.0.0.1:60890","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-02-26T21:40:41.748443Z","caller":"traceutil/trace.go:171","msg":"trace[236916845] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"390.886785ms","start":"2026-02-26T21:40:41.357546Z","end":"2026-02-26T21:40:41.748433Z","steps":["trace[236916845] 'process raft request' (duration: 390.563448ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:41.74851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:41.357539Z","time spent":"390.939476ms","remote":"127.0.0.1:60890","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-02-26T21:40:41.748652Z","caller":"traceutil/trace.go:171","msg":"trace[1134502968] linearizableReadLoop","detail":"{readStateIndex:1066; appliedIndex:1063; }","duration":"391.187352ms","start":"2026-02-26T21:40:41.357444Z","end":"2026-02-26T21:40:41.748631Z","steps":["trace[1134502968] 'read index received' (duration: 18.024671ms)","trace[1134502968] 'applied index is now lower than readState.Index' (duration: 373.16142ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:40:41.748744Z","caller":"traceutil/trace.go:171","msg":"trace[959441808] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"390.972177ms","start":"2026-02-26T21:40:41.357763Z","end":"2026-02-26T21:40:41.748735Z","steps":["trace[959441808] 'process raft request' (duration: 390.631369ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:41.748804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:41.357742Z","time spent":"391.033038ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:40:41.748821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.366525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:40:41.748906Z","caller":"traceutil/trace.go:171","msg":"trace[210247293] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:1027; }","duration":"391.443828ms","start":"2026-02-26T21:40:41.357414Z","end":"2026-02-26T21:40:41.748858Z","steps":["trace[210247293] 'agreement among raft nodes before linearized reading' (duration: 391.337505ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:41.748965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:41.357403Z","time spent":"391.54451ms","remote":"127.0.0.1:60740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-02-26T21:40:41.749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.794601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.227\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-26T21:40:41.749034Z","caller":"traceutil/trace.go:171","msg":"trace[1588113145] range","detail":"{range_begin:/registry/masterleases/162.253.55.227; range_end:; response_count:1; response_revision:1027; }","duration":"280.866573ms","start":"2026-02-26T21:40:41.468159Z","end":"2026-02-26T21:40:41.749025Z","steps":["trace[1588113145] 'agreement among raft nodes before linearized reading' (duration: 280.759ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:42.30654Z","caller":"traceutil/trace.go:171","msg":"trace[438782348] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"555.564145ms","start":"2026-02-26T21:40:41.750934Z","end":"2026-02-26T21:40:42.306498Z","steps":["trace[438782348] 'process raft request' (duration: 554.999782ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:42.30663Z","caller":"traceutil/trace.go:171","msg":"trace[18926728] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"555.532184ms","start":"2026-02-26T21:40:41.751083Z","end":"2026-02-26T21:40:42.306615Z","steps":["trace[18926728] 'process raft request' (duration: 555.34542ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:42.306691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.858624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T21:40:42.306711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:41.750912Z","time spent":"555.719228ms","remote":"127.0.0.1:60890","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-02-26T21:40:42.306735Z","caller":"traceutil/trace.go:171","msg":"trace[1261932380] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"555.736699ms","start":"2026-02-26T21:40:41.750991Z","end":"2026-02-26T21:40:42.306727Z","steps":["trace[1261932380] 'process raft request' (duration: 555.392732ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:42.306747Z","caller":"traceutil/trace.go:171","msg":"trace[1290180735] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1031; }","duration":"510.973017ms","start":"2026-02-26T21:40:41.795764Z","end":"2026-02-26T21:40:42.306737Z","steps":["trace[1290180735] 'agreement among raft nodes before linearized reading' (duration: 510.844334ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:42.306775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:41.750972Z","time spent":"555.78956ms","remote":"127.0.0.1:60890","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-02-26T21:40:42.306782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:41.795748Z","time spent":"511.025338ms","remote":"127.0.0.1:60668","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-02-26T21:40:42.306545Z","caller":"traceutil/trace.go:171","msg":"trace[620260080] linearizableReadLoop","detail":"{readStateIndex:1074; appliedIndex:1070; }","duration":"510.710471ms","start":"2026-02-26T21:40:41.795804Z","end":"2026-02-26T21:40:42.306515Z","steps":["trace[620260080] 'read index received' (duration: 35.344566ms)","trace[620260080] 'applied index is now lower than readState.Index' (duration: 475.364505ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:40:42.306867Z","caller":"traceutil/trace.go:171","msg":"trace[1915529520] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"552.29041ms","start":"2026-02-26T21:40:41.754564Z","end":"2026-02-26T21:40:42.306855Z","steps":["trace[1915529520] 'process raft request' (duration: 551.911732ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:42.306946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:41.754551Z","time spent":"552.347391ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:40:42.306703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:41.751068Z","time spent":"555.587526ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":495,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:40:42.639413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.268783ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T21:40:42.639648Z","caller":"traceutil/trace.go:171","msg":"trace[1947533494] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"807.799944ms","start":"2026-02-26T21:40:41.831819Z","end":"2026-02-26T21:40:42.639619Z","steps":["trace[1947533494] 'process raft request' (duration: 667.206814ms)","trace[1947533494] 'compare' (duration: 140.085979ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:40:42.639729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:41.831799Z","time spent":"807.892967ms","remote":"127.0.0.1:60702","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:40:42.639562Z","caller":"traceutil/trace.go:171","msg":"trace[1614049645] linearizableReadLoop","detail":"{readStateIndex:1075; appliedIndex:1074; }","duration":"328.233744ms","start":"2026-02-26T21:40:42.311306Z","end":"2026-02-26T21:40:42.63954Z","steps":["trace[1614049645] 'read index received' (duration: 187.789628ms)","trace[1614049645] 'applied index is now lower than readState.Index' (duration: 140.442576ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:40:42.640095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.763446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-02-26T21:40:42.640203Z","caller":"traceutil/trace.go:171","msg":"trace[586576404] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1032; }","duration":"328.92611ms","start":"2026-02-26T21:40:42.311255Z","end":"2026-02-26T21:40:42.640181Z","steps":["trace[586576404] 'agreement among raft nodes before linearized reading' (duration: 328.507791ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:42.640254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:42.311235Z","time spent":"329.009973ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":552,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-26T21:40:43.374166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.680096ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-26T21:40:43.374559Z","caller":"traceutil/trace.go:171","msg":"trace[364033535] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"1.061893984s","start":"2026-02-26T21:40:42.312612Z","end":"2026-02-26T21:40:43.374506Z","steps":["trace[364033535] 'process raft request' (duration: 798.735967ms)","trace[364033535] 'compare' (duration: 262.260537ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:40:43.37461Z","caller":"traceutil/trace.go:171","msg":"trace[507517789] linearizableReadLoop","detail":"{readStateIndex:1079; appliedIndex:1075; }","duration":"734.431337ms","start":"2026-02-26T21:40:42.640161Z","end":"2026-02-26T21:40:43.374592Z","steps":["trace[507517789] 'read index received' (duration: 471.175918ms)","trace[507517789] 'applied index is now lower than readState.Index' (duration: 263.251229ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:40:43.374599Z","caller":"traceutil/trace.go:171","msg":"trace[1857314986] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"1.061890285s","start":"2026-02-26T21:40:42.312671Z","end":"2026-02-26T21:40:43.374561Z","steps":["trace[1857314986] 'process raft request' (duration: 1.06170875s)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:43.374646Z","caller":"traceutil/trace.go:171","msg":"trace[231545948] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"1.06079458s","start":"2026-02-26T21:40:42.313811Z","end":"2026-02-26T21:40:43.374606Z","steps":["trace[231545948] 'process raft request' (duration: 1.060730178s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:43.37469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:42.3126Z","time spent":"1.062030117s","remote":"127.0.0.1:60732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":807,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:40:43.374774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:42.312664Z","time spent":"1.062033808s","remote":"127.0.0.1:60732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":771,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:40:43.374816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.062335015s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-26T21:40:43.374835Z","caller":"traceutil/trace.go:171","msg":"trace[257787179] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"1.060990704s","start":"2026-02-26T21:40:42.313763Z","end":"2026-02-26T21:40:43.374754Z","steps":["trace[257787179] 'process raft request' (duration: 1.060730218s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:43.375006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:42.313754Z","time spent":"1.061204099s","remote":"127.0.0.1:60732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":706,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:40:43.374844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.063062911s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:510"} {"level":"info","ts":"2026-02-26T21:40:43.375066Z","caller":"traceutil/trace.go:171","msg":"trace[298933117] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1036; }","duration":"1.063320517s","start":"2026-02-26T21:40:42.311732Z","end":"2026-02-26T21:40:43.375052Z","steps":["trace[298933117] 'agreement among raft nodes before linearized reading' (duration: 1.062956388s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:43.374842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:42.313806Z","time spent":"1.060926592s","remote":"127.0.0.1:60732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:40:43.3751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:42.311718Z","time spent":"1.063372829s","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-02-26T21:40:43.374867Z","caller":"traceutil/trace.go:171","msg":"trace[1749091035] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1036; }","duration":"1.062406356s","start":"2026-02-26T21:40:42.312445Z","end":"2026-02-26T21:40:43.374851Z","steps":["trace[1749091035] 'agreement among raft nodes before linearized reading' (duration: 1.062196301s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:43.375172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:42.312439Z","time spent":"1.062721273s","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-26T21:40:43.375011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060863661s","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-02-26T21:40:43.375464Z","caller":"traceutil/trace.go:171","msg":"trace[1190229432] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1036; }","duration":"1.061377573s","start":"2026-02-26T21:40:42.314075Z","end":"2026-02-26T21:40:43.375452Z","steps":["trace[1190229432] 'agreement among raft nodes before linearized reading' (duration: 1.060543614s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:43.375528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:42.31405Z","time spent":"1.061467164s","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":559,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-02-26T21:40:43.875274Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810625527845862,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T21:40:43.965167Z","caller":"traceutil/trace.go:171","msg":"trace[2055447043] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"1.319049626s","start":"2026-02-26T21:40:42.646069Z","end":"2026-02-26T21:40:43.965118Z","steps":["trace[2055447043] 'process raft request' (duration: 1.3165725s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:43.965448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:42.64605Z","time spent":"1.31924651s","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T21:40:44.178056Z","caller":"traceutil/trace.go:171","msg":"trace[543665379] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"1.058304512s","start":"2026-02-26T21:40:43.119713Z","end":"2026-02-26T21:40:44.178017Z","steps":["trace[543665379] 'process raft request' (duration: 980.522726ms)","trace[543665379] 'compare' (duration: 77.557911ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:40:44.178108Z","caller":"traceutil/trace.go:171","msg":"trace[807079139] linearizableReadLoop","detail":"{readStateIndex:1084; appliedIndex:1079; }","duration":"803.427063ms","start":"2026-02-26T21:40:43.37465Z","end":"2026-02-26T21:40:44.178077Z","steps":["trace[807079139] 'read index received' (duration: 588.012225ms)","trace[807079139] 'applied index is now lower than readState.Index' (duration: 215.413538ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T21:40:44.178222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:43.119685Z","time spent":"1.058456366s","remote":"127.0.0.1:60732","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":808,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T21:40:44.178671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.601065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-02-26T21:40:44.178656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.991155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:40:44.178709Z","caller":"traceutil/trace.go:171","msg":"trace[512315737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1041; }","duration":"424.662236ms","start":"2026-02-26T21:40:43.754035Z","end":"2026-02-26T21:40:44.178698Z","steps":["trace[512315737] 'agreement among raft nodes before linearized reading' (duration: 424.529363ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:44.178735Z","caller":"traceutil/trace.go:171","msg":"trace[846924248] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:0; response_revision:1041; }","duration":"687.129528ms","start":"2026-02-26T21:40:43.491587Z","end":"2026-02-26T21:40:44.178717Z","steps":["trace[846924248] 'agreement among raft nodes before linearized reading' (duration: 686.965554ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:44.178748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:43.754028Z","time spent":"424.708857ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-26T21:40:44.178773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:43.491561Z","time spent":"687.20616ms","remote":"127.0.0.1:60752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":0,"response size":28,"request content":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-02-26T21:40:44.178925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.041204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-02-26T21:40:44.178941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.536524051s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-02-26T21:40:44.178965Z","caller":"traceutil/trace.go:171","msg":"trace[1692585165] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1041; }","duration":"425.144117ms","start":"2026-02-26T21:40:43.753809Z","end":"2026-02-26T21:40:44.178953Z","steps":["trace[1692585165] 'agreement among raft nodes before linearized reading' (duration: 424.984873ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:44.178972Z","caller":"traceutil/trace.go:171","msg":"trace[1209187148] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1041; }","duration":"1.536589083s","start":"2026-02-26T21:40:42.642373Z","end":"2026-02-26T21:40:44.178962Z","steps":["trace[1209187148] 'agreement among raft nodes before linearized reading' (duration: 1.536502631s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:44.178997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:43.753782Z","time spent":"425.208288ms","remote":"127.0.0.1:60890","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-02-26T21:40:44.179029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.490935ms","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-02-26T21:40:44.179026Z","caller":"traceutil/trace.go:171","msg":"trace[1461058361] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"797.931509ms","start":"2026-02-26T21:40:43.381072Z","end":"2026-02-26T21:40:44.179004Z","steps":["trace[1461058361] 'process raft request' (duration: 796.930436ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:44.179126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.40082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-02-26T21:40:44.179003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:42.642355Z","time spent":"1.536640323s","remote":"127.0.0.1:60808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":445,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-02-26T21:40:44.179013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.988684ms","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-02-26T21:40:44.17916Z","caller":"traceutil/trace.go:171","msg":"trace[961566427] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1041; }","duration":"424.434911ms","start":"2026-02-26T21:40:43.754716Z","end":"2026-02-26T21:40:44.179151Z","steps":["trace[961566427] 'agreement among raft nodes before linearized reading' (duration: 424.302458ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:44.179174Z","caller":"traceutil/trace.go:171","msg":"trace[1291442992] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"798.038921ms","start":"2026-02-26T21:40:43.381125Z","end":"2026-02-26T21:40:44.179164Z","steps":["trace[1291442992] 'process raft request' (duration: 796.912576ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:44.179184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:43.381049Z","time spent":"798.02328ms","remote":"127.0.0.1:60890","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-02-26T21:40:44.179194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:43.75465Z","time spent":"424.533973ms","remote":"127.0.0.1:60890","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-02-26T21:40:44.179201Z","caller":"traceutil/trace.go:171","msg":"trace[1013608277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1041; }","duration":"425.24233ms","start":"2026-02-26T21:40:43.753936Z","end":"2026-02-26T21:40:44.179178Z","steps":["trace[1013608277] 'agreement among raft nodes before linearized reading' (duration: 424.864251ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:44.179252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:43.381118Z","time spent":"798.076972ms","remote":"127.0.0.1:60890","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-02-26T21:40:44.179255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:43.753914Z","time spent":"425.330191ms","remote":"127.0.0.1:60890","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":"info","ts":"2026-02-26T21:40:44.179047Z","caller":"traceutil/trace.go:171","msg":"trace[1076759388] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1041; }","duration":"425.544677ms","start":"2026-02-26T21:40:43.753496Z","end":"2026-02-26T21:40:44.17904Z","steps":["trace[1076759388] 'agreement among raft nodes before linearized reading' (duration: 425.448494ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:44.179295Z","caller":"traceutil/trace.go:171","msg":"trace[1890128721] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"798.246766ms","start":"2026-02-26T21:40:43.381033Z","end":"2026-02-26T21:40:44.17928Z","steps":["trace[1890128721] 'process raft request' (duration: 796.901515ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:44.17931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:43.753475Z","time spent":"425.826693ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-26T21:40:44.179366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:43.381004Z","time spent":"798.315687ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":495,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:40:44.179615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.382359891s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T21:40:44.179637Z","caller":"traceutil/trace.go:171","msg":"trace[1810147545] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1041; }","duration":"1.382423413s","start":"2026-02-26T21:40:42.797207Z","end":"2026-02-26T21:40:44.179631Z","steps":["trace[1810147545] 'agreement among raft nodes before linearized reading' (duration: 1.382373012s)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:44.179651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:42.797189Z","time spent":"1.382459353s","remote":"127.0.0.1:60674","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-02-26T21:40:58.838358Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4747810625527846041,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T21:40:58.847016Z","caller":"traceutil/trace.go:171","msg":"trace[731774191] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"512.86965ms","start":"2026-02-26T21:40:58.334113Z","end":"2026-02-26T21:40:58.846982Z","steps":["trace[731774191] 'process raft request' (duration: 512.685506ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:58.847193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:58.334102Z","time spent":"512.997253ms","remote":"127.0.0.1:60890","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-02-26T21:40:58.871459Z","caller":"traceutil/trace.go:171","msg":"trace[864504050] linearizableReadLoop","detail":"{readStateIndex:1164; appliedIndex:1162; }","duration":"533.797217ms","start":"2026-02-26T21:40:58.33763Z","end":"2026-02-26T21:40:58.871427Z","steps":["trace[864504050] 'read index received' (duration: 509.189325ms)","trace[864504050] 'applied index is now lower than readState.Index' (duration: 24.606392ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:40:58.871594Z","caller":"traceutil/trace.go:171","msg":"trace[1640195291] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"534.991845ms","start":"2026-02-26T21:40:58.336539Z","end":"2026-02-26T21:40:58.871531Z","steps":["trace[1640195291] 'process raft request' (duration: 534.721179ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:58.871828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.359975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-02-26T21:40:58.871847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.529868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"} {"level":"warn","ts":"2026-02-26T21:40:58.87187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.547304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-26T21:40:58.87193Z","caller":"traceutil/trace.go:171","msg":"trace[800742769] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1118; }","duration":"454.66389ms","start":"2026-02-26T21:40:58.417247Z","end":"2026-02-26T21:40:58.871911Z","steps":["trace[800742769] 'agreement among raft nodes before linearized reading' (duration: 454.429455ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:58.871939Z","caller":"traceutil/trace.go:171","msg":"trace[2081262183] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1118; }","duration":"530.641666ms","start":"2026-02-26T21:40:58.34128Z","end":"2026-02-26T21:40:58.871922Z","steps":["trace[2081262183] 'agreement among raft nodes before linearized reading' (duration: 530.446841ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:58.871972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:58.41723Z","time spent":"454.735443ms","remote":"127.0.0.1:60752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":644,"request content":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-02-26T21:40:58.871979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:58.341273Z","time spent":"530.698347ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-26T21:40:58.871935Z","caller":"traceutil/trace.go:171","msg":"trace[931194141] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1118; }","duration":"532.481808ms","start":"2026-02-26T21:40:58.339407Z","end":"2026-02-26T21:40:58.871889Z","steps":["trace[931194141] 'agreement among raft nodes before linearized reading' (duration: 532.224712ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:58.871837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:58.33653Z","time spent":"535.177419ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T21:40:58.872091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:58.339396Z","time spent":"532.680412ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T21:40:58.872414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.77964ms","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-02-26T21:40:58.872447Z","caller":"traceutil/trace.go:171","msg":"trace[239903452] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1118; }","duration":"534.824911ms","start":"2026-02-26T21:40:58.337613Z","end":"2026-02-26T21:40:58.872438Z","steps":["trace[239903452] 'agreement among raft nodes before linearized reading' (duration: 533.968182ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:40:58.872469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T21:40:58.337607Z","time spent":"534.857502ms","remote":"127.0.0.1:60890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-26T21:40:59.091894Z","caller":"traceutil/trace.go:171","msg":"trace[977872483] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"213.715669ms","start":"2026-02-26T21:40:58.87814Z","end":"2026-02-26T21:40:59.091856Z","steps":["trace[977872483] 'process raft request' (duration: 179.560499ms)","trace[977872483] 'compare' (duration: 33.72616ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:40:59.09193Z","caller":"traceutil/trace.go:171","msg":"trace[1728922751] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"213.76994ms","start":"2026-02-26T21:40:58.878146Z","end":"2026-02-26T21:40:59.091916Z","steps":["trace[1728922751] 'process raft request' (duration: 213.510945ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:59.092238Z","caller":"traceutil/trace.go:171","msg":"trace[443120288] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"212.795609ms","start":"2026-02-26T21:40:58.879434Z","end":"2026-02-26T21:40:59.092229Z","steps":["trace[443120288] 'process raft request' (duration: 212.294347ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:40:59.092628Z","caller":"traceutil/trace.go:171","msg":"trace[1097207071] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"143.834774ms","start":"2026-02-26T21:40:58.948778Z","end":"2026-02-26T21:40:59.092613Z","steps":["trace[1097207071] 'process raft request' (duration: 143.401165ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:41:21.262339Z","caller":"traceutil/trace.go:171","msg":"trace[530363208] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"238.468605ms","start":"2026-02-26T21:41:21.023833Z","end":"2026-02-26T21:41:21.262302Z","steps":["trace[530363208] 'process raft request' (duration: 168.692942ms)","trace[530363208] 'compare' (duration: 69.619509ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:41:21.578297Z","caller":"traceutil/trace.go:171","msg":"trace[494237402] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"105.430077ms","start":"2026-02-26T21:41:21.472824Z","end":"2026-02-26T21:41:21.578255Z","steps":["trace[494237402] 'process raft request' (duration: 28.381587ms)","trace[494237402] 'compare' (duration: 76.856205ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:41:56.230578Z","caller":"traceutil/trace.go:171","msg":"trace[1617215163] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"128.763281ms","start":"2026-02-26T21:41:56.101777Z","end":"2026-02-26T21:41:56.23054Z","steps":["trace[1617215163] 'process raft request' (duration: 76.928897ms)","trace[1617215163] 'compare' (duration: 51.67066ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:43:34.402829Z","caller":"traceutil/trace.go:171","msg":"trace[306341717] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"155.000911ms","start":"2026-02-26T21:43:34.247799Z","end":"2026-02-26T21:43:34.4028Z","steps":["trace[306341717] 'process raft request' (duration: 94.886202ms)","trace[306341717] 'compare' (duration: 60.024867ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:43:58.584293Z","caller":"traceutil/trace.go:171","msg":"trace[649422034] transaction","detail":"{read_only:false; response_revision:1971; number_of_response:1; }","duration":"121.259251ms","start":"2026-02-26T21:43:58.46299Z","end":"2026-02-26T21:43:58.58425Z","steps":["trace[649422034] 'process raft request' (duration: 120.964314ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:43:59.635393Z","caller":"traceutil/trace.go:171","msg":"trace[1285528159] transaction","detail":"{read_only:false; response_revision:1973; number_of_response:1; }","duration":"123.279019ms","start":"2026-02-26T21:43:59.512089Z","end":"2026-02-26T21:43:59.635368Z","steps":["trace[1285528159] 'process raft request' (duration: 122.935671ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T21:44:00.013654Z","caller":"traceutil/trace.go:171","msg":"trace[731867183] linearizableReadLoop","detail":"{readStateIndex:2059; appliedIndex:2058; }","duration":"151.05375ms","start":"2026-02-26T21:43:59.862571Z","end":"2026-02-26T21:44:00.013624Z","steps":["trace[731867183] 'read index received' (duration: 150.848615ms)","trace[731867183] 'applied index is now lower than readState.Index' (duration: 203.515µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T21:44:00.013805Z","caller":"traceutil/trace.go:171","msg":"trace[19941737] transaction","detail":"{read_only:false; response_revision:1976; number_of_response:1; }","duration":"177.220535ms","start":"2026-02-26T21:43:59.836568Z","end":"2026-02-26T21:44:00.013789Z","steps":["trace[19941737] 'process raft request' (duration: 176.894077ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:44:00.014057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.643567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:510"} {"level":"info","ts":"2026-02-26T21:44:00.014135Z","caller":"traceutil/trace.go:171","msg":"trace[1593044349] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1976; }","duration":"149.743779ms","start":"2026-02-26T21:43:59.864372Z","end":"2026-02-26T21:44:00.014115Z","steps":["trace[1593044349] 'agreement among raft nodes before linearized reading' (duration: 149.560655ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:44:00.014157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.540484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-26T21:44:00.014241Z","caller":"traceutil/trace.go:171","msg":"trace[1334708522] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1976; }","duration":"126.669747ms","start":"2026-02-26T21:43:59.887553Z","end":"2026-02-26T21:44:00.014223Z","steps":["trace[1334708522] 'agreement among raft nodes before linearized reading' (duration: 126.481782ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:44:00.014528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.918499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-26T21:44:00.014698Z","caller":"traceutil/trace.go:171","msg":"trace[1744887181] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1976; }","duration":"152.124054ms","start":"2026-02-26T21:43:59.862516Z","end":"2026-02-26T21:44:00.01464Z","steps":["trace[1744887181] 'agreement among raft nodes before linearized reading' (duration: 151.594932ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T21:44:30.985173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.993731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-2pdpd\" ","response":"range_response_count:1 size:4908"} {"level":"info","ts":"2026-02-26T21:44:30.985288Z","caller":"traceutil/trace.go:171","msg":"trace[716456445] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-2pdpd; range_end:; response_count:1; response_revision:2129; }","duration":"101.288418ms","start":"2026-02-26T21:44:30.883976Z","end":"2026-02-26T21:44:30.985265Z","steps":["trace[716456445] 'range keys from in-memory index tree' (duration: 100.767016ms)"],"step_count":1}