{"level":"warn","ts":"2026-07-02T10:06:46.740279Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T10:06:46.740428Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.199:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.199:2380","--initial-cluster=instance=https://199.19.213.199:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.199:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.199: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-07-02T10:06:46.740528Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T10:06:46.740541Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.199:2380"]} {"level":"info","ts":"2026-07-02T10:06:46.740568Z","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-07-02T10:06:46.741558Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.199:2379"]} {"level":"info","ts":"2026-07-02T10:06:46.741707Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.199:2380"],"listen-peer-urls":["https://199.19.213.199:2380"],"advertise-client-urls":["https://199.19.213.199:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.199:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.199: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-07-02T10:06:46.746848Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.728025ms"} {"level":"info","ts":"2026-07-02T10:06:46.755028Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6d660142aa1b7ce9","cluster-id":"6964c025ad43a005"} {"level":"info","ts":"2026-07-02T10:06:46.755173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 switched to configuration voters=()"} {"level":"info","ts":"2026-07-02T10:06:46.755215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 became follower at term 0"} {"level":"info","ts":"2026-07-02T10:06:46.755285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6d660142aa1b7ce9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-02T10:06:46.755377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 became follower at term 1"} {"level":"info","ts":"2026-07-02T10:06:46.755485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 switched to configuration voters=(7882989583592029417)"} {"level":"warn","ts":"2026-07-02T10:06:46.76297Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-02T10:06:46.764949Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-02T10:06:46.768516Z","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-07-02T10:06:46.771845Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6d660142aa1b7ce9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-02T10:06:46.772924Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6d660142aa1b7ce9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-02T10:06:46.773253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 switched to configuration voters=(7882989583592029417)"} {"level":"info","ts":"2026-07-02T10:06:46.773372Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6964c025ad43a005","local-member-id":"6d660142aa1b7ce9","added-peer-id":"6d660142aa1b7ce9","added-peer-peer-urls":["https://199.19.213.199:2380"]} {"level":"info","ts":"2026-07-02T10:06:46.773387Z","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-07-02T10:06:46.773534Z","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-07-02T10:06:46.77356Z","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-07-02T10:06:46.781211Z","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-07-02T10:06:46.781338Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.199:2380"} {"level":"info","ts":"2026-07-02T10:06:46.781432Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.199:2380"} {"level":"info","ts":"2026-07-02T10:06:46.781496Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6d660142aa1b7ce9","initial-advertise-peer-urls":["https://199.19.213.199:2380"],"listen-peer-urls":["https://199.19.213.199:2380"],"advertise-client-urls":["https://199.19.213.199:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.199:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-02T10:06:46.781548Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-02T10:06:47.156657Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 is starting a new election at term 1"} {"level":"info","ts":"2026-07-02T10:06:47.156723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-02T10:06:47.156768Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 received MsgPreVoteResp from 6d660142aa1b7ce9 at term 1"} {"level":"info","ts":"2026-07-02T10:06:47.156789Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 became candidate at term 2"} {"level":"info","ts":"2026-07-02T10:06:47.1568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 received MsgVoteResp from 6d660142aa1b7ce9 at term 2"} {"level":"info","ts":"2026-07-02T10:06:47.156815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d660142aa1b7ce9 became leader at term 2"} {"level":"info","ts":"2026-07-02T10:06:47.156829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6d660142aa1b7ce9 elected leader 6d660142aa1b7ce9 at term 2"} {"level":"info","ts":"2026-07-02T10:06:47.159843Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6d660142aa1b7ce9","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.199:2379]}","request-path":"/0/members/6d660142aa1b7ce9/attributes","cluster-id":"6964c025ad43a005","publish-timeout":"7s"} {"level":"info","ts":"2026-07-02T10:06:47.159884Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T10:06:47.16027Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T10:06:47.160568Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-02T10:06:47.160668Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-02T10:06:47.164495Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.199:2379"} {"level":"info","ts":"2026-07-02T10:06:47.166577Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-02T10:06:47.167083Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T10:06:47.169504Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6964c025ad43a005","local-member-id":"6d660142aa1b7ce9","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T10:06:47.169592Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T10:06:47.169634Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T10:06:52.188715Z","caller":"traceutil/trace.go:171","msg":"trace[1472182937] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"100.399019ms","start":"2026-07-02T10:06:52.088251Z","end":"2026-07-02T10:06:52.18865Z","steps":["trace[1472182937] 'process raft request' (duration: 85.278365ms)","trace[1472182937] 'compare' (duration: 14.866205ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:06:52.560029Z","caller":"traceutil/trace.go:171","msg":"trace[201505079] transaction","detail":"{read_only:false; response_revision:241; number_of_response:1; }","duration":"132.55182ms","start":"2026-07-02T10:06:52.427436Z","end":"2026-07-02T10:06:52.559988Z","steps":["trace[201505079] 'process raft request' (duration: 75.815387ms)","trace[201505079] 'compare' (duration: 56.552207ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:06:53.071889Z","caller":"traceutil/trace.go:171","msg":"trace[1592944416] linearizableReadLoop","detail":"{readStateIndex:258; appliedIndex:256; }","duration":"108.041589ms","start":"2026-07-02T10:06:52.963828Z","end":"2026-07-02T10:06:53.07187Z","steps":["trace[1592944416] 'read index received' (duration: 50.453358ms)","trace[1592944416] 'applied index is now lower than readState.Index' (duration: 57.587391ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:06:53.071977Z","caller":"traceutil/trace.go:171","msg":"trace[1548241578] transaction","detail":"{read_only:false; response_revision:252; number_of_response:1; }","duration":"108.613397ms","start":"2026-07-02T10:06:52.963302Z","end":"2026-07-02T10:06:53.071915Z","steps":["trace[1548241578] 'process raft request' (duration: 108.458713ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:06:53.072115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.257697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-07-02T10:06:53.072163Z","caller":"traceutil/trace.go:171","msg":"trace[643113354] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:252; }","duration":"108.37328ms","start":"2026-07-02T10:06:52.963777Z","end":"2026-07-02T10:06:53.07215Z","steps":["trace[643113354] 'agreement among raft nodes before linearized reading' (duration: 108.193764ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:06:53.192542Z","caller":"traceutil/trace.go:171","msg":"trace[1404829776] linearizableReadLoop","detail":"{readStateIndex:259; appliedIndex:258; }","duration":"120.547058ms","start":"2026-07-02T10:06:53.071953Z","end":"2026-07-02T10:06:53.1925Z","steps":["trace[1404829776] 'read index received' (duration: 60.401823ms)","trace[1404829776] 'applied index is now lower than readState.Index' (duration: 60.143615ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:06:53.192598Z","caller":"traceutil/trace.go:171","msg":"trace[1532722569] transaction","detail":"{read_only:false; number_of_response:0; response_revision:252; }","duration":"123.180663ms","start":"2026-07-02T10:06:53.069391Z","end":"2026-07-02T10:06:53.192572Z","steps":["trace[1532722569] 'process raft request' (duration: 62.877143ms)","trace[1532722569] 'compare' (duration: 60.155355ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:06:53.192632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.728023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:115"} {"level":"info","ts":"2026-07-02T10:06:53.192714Z","caller":"traceutil/trace.go:171","msg":"trace[1972438459] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:252; }","duration":"169.864228ms","start":"2026-07-02T10:06:53.02283Z","end":"2026-07-02T10:06:53.192694Z","steps":["trace[1972438459] 'agreement among raft nodes before linearized reading' (duration: 169.686282ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:06:53.192762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.495691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T10:06:53.19273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.88728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:06:53.192808Z","caller":"traceutil/trace.go:171","msg":"trace[880297209] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-after-finished-controller; range_end:; response_count:0; response_revision:252; }","duration":"227.609954ms","start":"2026-07-02T10:06:52.965181Z","end":"2026-07-02T10:06:53.192791Z","steps":["trace[880297209] 'agreement among raft nodes before linearized reading' (duration: 227.49546ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:06:53.192843Z","caller":"traceutil/trace.go:171","msg":"trace[1760316604] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:252; }","duration":"227.023715ms","start":"2026-07-02T10:06:52.965782Z","end":"2026-07-02T10:06:53.192805Z","steps":["trace[1760316604] 'agreement among raft nodes before linearized reading' (duration: 226.862479ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:06:53.205707Z","caller":"traceutil/trace.go:171","msg":"trace[394484246] transaction","detail":"{read_only:false; response_revision:253; number_of_response:1; }","duration":"128.982411ms","start":"2026-07-02T10:06:53.076709Z","end":"2026-07-02T10:06:53.205692Z","steps":["trace[394484246] 'process raft request' (duration: 128.751094ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:06:53.205787Z","caller":"traceutil/trace.go:171","msg":"trace[1596151548] transaction","detail":"{read_only:false; number_of_response:0; response_revision:253; }","duration":"120.837116ms","start":"2026-07-02T10:06:53.084938Z","end":"2026-07-02T10:06:53.205775Z","steps":["trace[1596151548] 'process raft request' (duration: 120.6766ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:06:53.205874Z","caller":"traceutil/trace.go:171","msg":"trace[804944881] transaction","detail":"{read_only:false; number_of_response:0; response_revision:254; }","duration":"118.486869ms","start":"2026-07-02T10:06:53.087373Z","end":"2026-07-02T10:06:53.20586Z","steps":["trace[804944881] 'process raft request' (duration: 118.327663ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:06:53.206035Z","caller":"traceutil/trace.go:171","msg":"trace[595960648] transaction","detail":"{read_only:false; number_of_response:0; response_revision:253; }","duration":"120.980151ms","start":"2026-07-02T10:06:53.085045Z","end":"2026-07-02T10:06:53.206025Z","steps":["trace[595960648] 'process raft request' (duration: 120.596369ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:06:53.206165Z","caller":"traceutil/trace.go:171","msg":"trace[1917396606] transaction","detail":"{read_only:false; response_revision:255; number_of_response:1; }","duration":"116.824116ms","start":"2026-07-02T10:06:53.089331Z","end":"2026-07-02T10:06:53.206155Z","steps":["trace[1917396606] 'process raft request' (duration: 116.388181ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:06:53.20618Z","caller":"traceutil/trace.go:171","msg":"trace[537858227] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"119.898826ms","start":"2026-07-02T10:06:53.086265Z","end":"2026-07-02T10:06:53.206164Z","steps":["trace[537858227] 'process raft request' (duration: 119.395869ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:06:53.206214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.371128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-07-02T10:06:53.206254Z","caller":"traceutil/trace.go:171","msg":"trace[1317477971] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:255; }","duration":"130.45777ms","start":"2026-07-02T10:06:53.075785Z","end":"2026-07-02T10:06:53.206243Z","steps":["trace[1317477971] 'agreement among raft nodes before linearized reading' (duration: 130.361337ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:28.091028Z","caller":"traceutil/trace.go:171","msg":"trace[2063006364] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"101.156424ms","start":"2026-07-02T10:07:27.98984Z","end":"2026-07-02T10:07:28.090996Z","steps":["trace[2063006364] 'process raft request' (duration: 100.600326ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:28.09151Z","caller":"traceutil/trace.go:171","msg":"trace[1592172825] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"101.237316ms","start":"2026-07-02T10:07:27.989904Z","end":"2026-07-02T10:07:28.091141Z","steps":["trace[1592172825] 'process raft request' (duration: 100.663458ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:28.717523Z","caller":"traceutil/trace.go:171","msg":"trace[661656165] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"167.620494ms","start":"2026-07-02T10:07:28.549866Z","end":"2026-07-02T10:07:28.717486Z","steps":["trace[661656165] 'process raft request' (duration: 167.347116ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:28.723777Z","caller":"traceutil/trace.go:171","msg":"trace[1603417610] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"121.004192ms","start":"2026-07-02T10:07:28.602749Z","end":"2026-07-02T10:07:28.723753Z","steps":["trace[1603417610] 'process raft request' (duration: 120.688231ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:28.723996Z","caller":"traceutil/trace.go:171","msg":"trace[620493927] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"170.281881ms","start":"2026-07-02T10:07:28.553672Z","end":"2026-07-02T10:07:28.723954Z","steps":["trace[620493927] 'process raft request' (duration: 169.526077ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:34.642484Z","caller":"traceutil/trace.go:171","msg":"trace[762746230] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"262.924667ms","start":"2026-07-02T10:07:34.37952Z","end":"2026-07-02T10:07:34.642445Z","steps":["trace[762746230] 'process raft request' (duration: 262.70228ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:35.616032Z","caller":"traceutil/trace.go:171","msg":"trace[696034646] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:630; }","duration":"496.662611ms","start":"2026-07-02T10:07:35.119345Z","end":"2026-07-02T10:07:35.616008Z","steps":["trace[696034646] 'read index received' (duration: 495.71594ms)","trace[696034646] 'applied index is now lower than readState.Index' (duration: 945.371µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:07:35.616225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.864618ms","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-07-02T10:07:35.616189Z","caller":"traceutil/trace.go:171","msg":"trace[833123280] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"564.874669ms","start":"2026-07-02T10:07:35.05126Z","end":"2026-07-02T10:07:35.616135Z","steps":["trace[833123280] 'process raft request' (duration: 564.061253ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:07:35.616452Z","caller":"traceutil/trace.go:171","msg":"trace[219457300] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:603; }","duration":"497.188948ms","start":"2026-07-02T10:07:35.119254Z","end":"2026-07-02T10:07:35.616443Z","steps":["trace[219457300] 'agreement among raft nodes before linearized reading' (duration: 496.883938ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:35.616483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:07:35.119228Z","time spent":"497.25002ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-02T10:07:35.616923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.912389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-68h77\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-02T10:07:35.616977Z","caller":"traceutil/trace.go:171","msg":"trace[1933007625] range","detail":"{range_begin:/registry/pods/kube-system/cilium-68h77; range_end:; response_count:1; response_revision:603; }","duration":"496.991982ms","start":"2026-07-02T10:07:35.119969Z","end":"2026-07-02T10:07:35.616961Z","steps":["trace[1933007625] 'agreement among raft nodes before linearized reading' (duration: 496.781195ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:35.616991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:07:35.051231Z","time spent":"565.244631ms","remote":"127.0.0.1:33304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:07:35.617006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:07:35.11996Z","time spent":"497.039703ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-68h77\" "} {"level":"warn","ts":"2026-07-02T10:07:35.617215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.632456ms","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-07-02T10:07:35.617262Z","caller":"traceutil/trace.go:171","msg":"trace[1659121871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:603; }","duration":"160.72422ms","start":"2026-07-02T10:07:35.456525Z","end":"2026-07-02T10:07:35.617249Z","steps":["trace[1659121871] 'agreement among raft nodes before linearized reading' (duration: 160.618606ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:51.865307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.016323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:07:51.865425Z","caller":"traceutil/trace.go:171","msg":"trace[1572860233] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:764; }","duration":"190.212119ms","start":"2026-07-02T10:07:51.67519Z","end":"2026-07-02T10:07:51.865402Z","steps":["trace[1572860233] 'count revisions from in-memory index tree' (duration: 189.89713ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:51.865391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.203121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-q4rf2\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-07-02T10:07:51.86552Z","caller":"traceutil/trace.go:171","msg":"trace[1560018426] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-q4rf2; range_end:; response_count:1; response_revision:764; }","duration":"623.393886ms","start":"2026-07-02T10:07:51.242095Z","end":"2026-07-02T10:07:51.865489Z","steps":["trace[1560018426] 'range keys from in-memory index tree' (duration: 623.022786ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:51.865491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.191168ms","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-07-02T10:07:51.865587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:07:51.24207Z","time spent":"623.500409ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-q4rf2\" "} {"level":"info","ts":"2026-07-02T10:07:51.865614Z","caller":"traceutil/trace.go:171","msg":"trace[686068574] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:764; }","duration":"153.428594ms","start":"2026-07-02T10:07:51.712157Z","end":"2026-07-02T10:07:51.865585Z","steps":["trace[686068574] 'range keys from in-memory index tree' (duration: 152.915091ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:51.865743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.092347ms","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-07-02T10:07:51.865932Z","caller":"traceutil/trace.go:171","msg":"trace[1181755583] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:764; }","duration":"152.379435ms","start":"2026-07-02T10:07:51.713517Z","end":"2026-07-02T10:07:51.865896Z","steps":["trace[1181755583] 'range keys from in-memory index tree' (duration: 151.688806ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:07:51.865995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.658403ms","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-07-02T10:07:51.866056Z","caller":"traceutil/trace.go:171","msg":"trace[2030029136] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:764; }","duration":"152.772855ms","start":"2026-07-02T10:07:51.713267Z","end":"2026-07-02T10:07:51.86604Z","steps":["trace[2030029136] 'range keys from in-memory index tree' (duration: 151.822829ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:08:25.292908Z","caller":"traceutil/trace.go:171","msg":"trace[2131322015] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"277.414089ms","start":"2026-07-02T10:08:25.015457Z","end":"2026-07-02T10:08:25.292871Z","steps":["trace[2131322015] 'process raft request' (duration: 277.10419ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:08:26.564894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.129039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:08:26.56503Z","caller":"traceutil/trace.go:171","msg":"trace[970531088] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:983; }","duration":"376.280273ms","start":"2026-07-02T10:08:26.188686Z","end":"2026-07-02T10:08:26.564966Z","steps":["trace[970531088] 'count revisions from in-memory index tree' (duration: 375.963463ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:08:26.565094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:08:26.188661Z","time spent":"376.416026ms","remote":"127.0.0.1:33360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:08:26.565366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.469651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:08:26.565546Z","caller":"traceutil/trace.go:171","msg":"trace[1732270870] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:983; }","duration":"178.715038ms","start":"2026-07-02T10:08:26.386802Z","end":"2026-07-02T10:08:26.565517Z","steps":["trace[1732270870] 'count revisions from in-memory index tree' (duration: 178.343599ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:08:27.467213Z","caller":"traceutil/trace.go:171","msg":"trace[789888557] linearizableReadLoop","detail":"{readStateIndex:1026; appliedIndex:1025; }","duration":"162.714453ms","start":"2026-07-02T10:08:27.304463Z","end":"2026-07-02T10:08:27.467178Z","steps":["trace[789888557] 'read index received' (duration: 162.380673ms)","trace[789888557] 'applied index is now lower than readState.Index' (duration: 332.66µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:08:27.467562Z","caller":"traceutil/trace.go:171","msg":"trace[1948999472] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"166.637373ms","start":"2026-07-02T10:08:27.300878Z","end":"2026-07-02T10:08:27.467515Z","steps":["trace[1948999472] 'process raft request' (duration: 166.112419ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:08:27.467629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.115353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-02T10:08:27.46771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.954155ms","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-07-02T10:08:27.467753Z","caller":"traceutil/trace.go:171","msg":"trace[2076524840] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:984; }","duration":"160.055819ms","start":"2026-07-02T10:08:27.307685Z","end":"2026-07-02T10:08:27.467741Z","steps":["trace[2076524840] 'agreement among raft nodes before linearized reading' (duration: 159.829182ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:08:27.467745Z","caller":"traceutil/trace.go:171","msg":"trace[197326810] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:984; }","duration":"163.31622ms","start":"2026-07-02T10:08:27.304402Z","end":"2026-07-02T10:08:27.467718Z","steps":["trace[197326810] 'agreement among raft nodes before linearized reading' (duration: 163.068063ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:08:48.370594Z","caller":"traceutil/trace.go:171","msg":"trace[1723608556] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"188.660949ms","start":"2026-07-02T10:08:48.181915Z","end":"2026-07-02T10:08:48.370576Z","steps":["trace[1723608556] 'process raft request' (duration: 188.347997ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:08:48.370513Z","caller":"traceutil/trace.go:171","msg":"trace[1204990346] linearizableReadLoop","detail":"{readStateIndex:1098; appliedIndex:1097; }","duration":"188.016024ms","start":"2026-07-02T10:08:48.182462Z","end":"2026-07-02T10:08:48.370479Z","steps":["trace[1204990346] 'read index received' (duration: 187.819121ms)","trace[1204990346] 'applied index is now lower than readState.Index' (duration: 195.513µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:08:48.371013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.524619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-02T10:08:48.371055Z","caller":"traceutil/trace.go:171","msg":"trace[1560307405] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1052; }","duration":"188.601806ms","start":"2026-07-02T10:08:48.182443Z","end":"2026-07-02T10:08:48.371045Z","steps":["trace[1560307405] 'agreement among raft nodes before linearized reading' (duration: 188.402762ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:08:48.371271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.40517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-07-02T10:08:48.371285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.443922ms","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-07-02T10:08:48.371305Z","caller":"traceutil/trace.go:171","msg":"trace[2061024392] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1052; }","duration":"177.450403ms","start":"2026-07-02T10:08:48.193842Z","end":"2026-07-02T10:08:48.371293Z","steps":["trace[2061024392] 'agreement among raft nodes before linearized reading' (duration: 177.361656ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:08:48.371345Z","caller":"traceutil/trace.go:171","msg":"trace[1674350885] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1052; }","duration":"177.530928ms","start":"2026-07-02T10:08:48.193799Z","end":"2026-07-02T10:08:48.37133Z","steps":["trace[1674350885] 'agreement among raft nodes before linearized reading' (duration: 177.396809ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:08:48.563831Z","caller":"traceutil/trace.go:171","msg":"trace[1967580964] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"187.435084ms","start":"2026-07-02T10:08:48.37636Z","end":"2026-07-02T10:08:48.563795Z","steps":["trace[1967580964] 'process raft request' (duration: 175.629586ms)","trace[1967580964] 'compare' (duration: 11.666848ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:08:48.596606Z","caller":"traceutil/trace.go:171","msg":"trace[1959545253] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"219.415892ms","start":"2026-07-02T10:08:48.377158Z","end":"2026-07-02T10:08:48.596574Z","steps":["trace[1959545253] 'process raft request' (duration: 219.144973ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:08:48.596751Z","caller":"traceutil/trace.go:171","msg":"trace[987029280] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"219.450303ms","start":"2026-07-02T10:08:48.377282Z","end":"2026-07-02T10:08:48.596732Z","steps":["trace[987029280] 'process raft request' (duration: 219.237858ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:08:51.802646Z","caller":"traceutil/trace.go:171","msg":"trace[730047677] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"105.804425ms","start":"2026-07-02T10:08:51.696794Z","end":"2026-07-02T10:08:51.802598Z","steps":["trace[730047677] 'process raft request' (duration: 27.764744ms)","trace[730047677] 'compare' (duration: 77.855538ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:09:04.427809Z","caller":"traceutil/trace.go:171","msg":"trace[1012460500] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"236.139418ms","start":"2026-07-02T10:09:04.191638Z","end":"2026-07-02T10:09:04.427778Z","steps":["trace[1012460500] 'process raft request' (duration: 235.961162ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:09:06.150273Z","caller":"traceutil/trace.go:171","msg":"trace[217309050] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"101.793425ms","start":"2026-07-02T10:09:06.048453Z","end":"2026-07-02T10:09:06.150247Z","steps":["trace[217309050] 'process raft request' (duration: 101.569448ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:09:08.055744Z","caller":"traceutil/trace.go:171","msg":"trace[649779586] linearizableReadLoop","detail":"{readStateIndex:1221; appliedIndex:1220; }","duration":"125.775122ms","start":"2026-07-02T10:09:07.929947Z","end":"2026-07-02T10:09:08.055722Z","steps":["trace[649779586] 'read index received' (duration: 110.029596ms)","trace[649779586] 'applied index is now lower than readState.Index' (duration: 15.744696ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:09:08.055852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.887305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:09:08.055876Z","caller":"traceutil/trace.go:171","msg":"trace[1468401971] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1169; }","duration":"125.947597ms","start":"2026-07-02T10:09:07.929919Z","end":"2026-07-02T10:09:08.055867Z","steps":["trace[1468401971] 'agreement among raft nodes before linearized reading' (duration: 125.889086ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:09:08.055883Z","caller":"traceutil/trace.go:171","msg":"trace[827911294] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"171.078545ms","start":"2026-07-02T10:09:07.88478Z","end":"2026-07-02T10:09:08.055859Z","steps":["trace[827911294] 'process raft request' (duration: 155.144243ms)","trace[827911294] 'compare' (duration: 15.470779ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:09:20.730588Z","caller":"traceutil/trace.go:171","msg":"trace[532228422] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"110.491989ms","start":"2026-07-02T10:09:20.620058Z","end":"2026-07-02T10:09:20.73055Z","steps":["trace[532228422] 'process raft request' (duration: 109.515072ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:09:24.75418Z","caller":"traceutil/trace.go:171","msg":"trace[1366251778] linearizableReadLoop","detail":"{readStateIndex:1294; appliedIndex:1293; }","duration":"146.542101ms","start":"2026-07-02T10:09:24.607616Z","end":"2026-07-02T10:09:24.754158Z","steps":["trace[1366251778] 'read index received' (duration: 146.373647ms)","trace[1366251778] 'applied index is now lower than readState.Index' (duration: 167.424µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:09:24.754405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.757997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bjzt6\" ","response":"range_response_count:1 size:11061"} {"level":"info","ts":"2026-07-02T10:09:24.754468Z","caller":"traceutil/trace.go:171","msg":"trace[1658702761] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-bjzt6; range_end:; response_count:1; response_revision:1239; }","duration":"146.860939ms","start":"2026-07-02T10:09:24.607591Z","end":"2026-07-02T10:09:24.754452Z","steps":["trace[1658702761] 'agreement among raft nodes before linearized reading' (duration: 146.673864ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:09:24.754432Z","caller":"traceutil/trace.go:171","msg":"trace[729138225] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"205.096299ms","start":"2026-07-02T10:09:24.549305Z","end":"2026-07-02T10:09:24.754401Z","steps":["trace[729138225] 'process raft request' (duration: 204.704938ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:09:25.253977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.284283ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T10:09:25.254103Z","caller":"traceutil/trace.go:171","msg":"trace[1647590799] linearizableReadLoop","detail":"{readStateIndex:1295; appliedIndex:1294; }","duration":"442.199984ms","start":"2026-07-02T10:09:24.811887Z","end":"2026-07-02T10:09:25.254087Z","steps":["trace[1647590799] 'read index received' (duration: 145.47025ms)","trace[1647590799] 'applied index is now lower than readState.Index' (duration: 296.728094ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:09:25.254192Z","caller":"traceutil/trace.go:171","msg":"trace[170187209] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"483.216517ms","start":"2026-07-02T10:09:24.770963Z","end":"2026-07-02T10:09:25.25418Z","steps":["trace[170187209] 'process raft request' (duration: 186.456391ms)","trace[170187209] 'compare' (duration: 295.930982ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:09:25.254267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:09:24.770928Z","time spent":"483.293378ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11375,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:09:25.254372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.455019ms","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-07-02T10:09:25.25443Z","caller":"traceutil/trace.go:171","msg":"trace[536298893] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1240; }","duration":"438.51949ms","start":"2026-07-02T10:09:24.815895Z","end":"2026-07-02T10:09:25.254415Z","steps":["trace[536298893] 'agreement among raft nodes before linearized reading' (duration: 438.386127ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:09:25.254457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:09:24.815839Z","time spent":"438.612353ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-02T10:09:25.254604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.210046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T10:09:25.254645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.205298ms","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-07-02T10:09:25.254675Z","caller":"traceutil/trace.go:171","msg":"trace[1598280129] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1240; }","duration":"322.337601ms","start":"2026-07-02T10:09:24.932324Z","end":"2026-07-02T10:09:25.254661Z","steps":["trace[1598280129] 'agreement among raft nodes before linearized reading' (duration: 322.207786ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:09:25.254693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.784702ms","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-07-02T10:09:25.254712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:09:24.932303Z","time spent":"322.402792ms","remote":"127.0.0.1:33218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-02T10:09:25.25473Z","caller":"traceutil/trace.go:171","msg":"trace[1074359181] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1240; }","duration":"442.877793ms","start":"2026-07-02T10:09:24.811842Z","end":"2026-07-02T10:09:25.254719Z","steps":["trace[1074359181] 'agreement among raft nodes before linearized reading' (duration: 442.729579ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:09:25.254762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:09:24.811814Z","time spent":"442.941326ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-02T10:09:25.254681Z","caller":"traceutil/trace.go:171","msg":"trace[430192537] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1240; }","duration":"428.25622ms","start":"2026-07-02T10:09:24.826416Z","end":"2026-07-02T10:09:25.254672Z","steps":["trace[430192537] 'agreement among raft nodes before linearized reading' (duration: 428.166027ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:09:25.254841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:09:24.826409Z","time spent":"428.426004ms","remote":"127.0.0.1:33452","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":"info","ts":"2026-07-02T10:09:25.487797Z","caller":"traceutil/trace.go:171","msg":"trace[1891772541] linearizableReadLoop","detail":"{readStateIndex:1296; appliedIndex:1295; }","duration":"228.744999ms","start":"2026-07-02T10:09:25.25903Z","end":"2026-07-02T10:09:25.487775Z","steps":["trace[1891772541] 'read index received' (duration: 228.602015ms)","trace[1891772541] 'applied index is now lower than readState.Index' (duration: 141.884µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:09:25.487822Z","caller":"traceutil/trace.go:171","msg":"trace[1527886518] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"228.825611ms","start":"2026-07-02T10:09:25.258979Z","end":"2026-07-02T10:09:25.487804Z","steps":["trace[1527886518] 'process raft request' (duration: 228.656626ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:09:25.487917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.870982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:09:25.487944Z","caller":"traceutil/trace.go:171","msg":"trace[233887652] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1241; }","duration":"228.932934ms","start":"2026-07-02T10:09:25.259001Z","end":"2026-07-02T10:09:25.487934Z","steps":["trace[233887652] 'agreement among raft nodes before linearized reading' (duration: 228.870302ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:09:25.517397Z","caller":"traceutil/trace.go:171","msg":"trace[582728280] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"258.243424ms","start":"2026-07-02T10:09:25.259119Z","end":"2026-07-02T10:09:25.517363Z","steps":["trace[582728280] 'process raft request' (duration: 257.950986ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:09:25.517872Z","caller":"traceutil/trace.go:171","msg":"trace[608787732] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"257.901403ms","start":"2026-07-02T10:09:25.25994Z","end":"2026-07-02T10:09:25.517841Z","steps":["trace[608787732] 'process raft request' (duration: 257.351908ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:09:25.517915Z","caller":"traceutil/trace.go:171","msg":"trace[1454381792] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"258.601695ms","start":"2026-07-02T10:09:25.259176Z","end":"2026-07-02T10:09:25.517777Z","steps":["trace[1454381792] 'process raft request' (duration: 258.06154ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:09:25.518425Z","caller":"traceutil/trace.go:171","msg":"trace[438777530] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"256.833194ms","start":"2026-07-02T10:09:25.261579Z","end":"2026-07-02T10:09:25.518412Z","steps":["trace[438777530] 'process raft request' (duration: 256.136684ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:09:25.521406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.602478ms","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-07-02T10:09:25.521478Z","caller":"traceutil/trace.go:171","msg":"trace[1847909267] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1246; }","duration":"214.726742ms","start":"2026-07-02T10:09:25.306734Z","end":"2026-07-02T10:09:25.521461Z","steps":["trace[1847909267] 'agreement among raft nodes before linearized reading' (duration: 214.32598ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:09:25.521966Z","caller":"traceutil/trace.go:171","msg":"trace[1461048783] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"259.736677ms","start":"2026-07-02T10:09:25.262183Z","end":"2026-07-02T10:09:25.52192Z","steps":["trace[1461048783] 'process raft request' (duration: 256.160906ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:09:26.62205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.386006ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-02T10:09:26.622244Z","caller":"traceutil/trace.go:171","msg":"trace[1290107663] linearizableReadLoop","detail":"{readStateIndex:1305; appliedIndex:1304; }","duration":"640.815649ms","start":"2026-07-02T10:09:25.981411Z","end":"2026-07-02T10:09:26.622227Z","steps":["trace[1290107663] 'read index received' (duration: 148.230387ms)","trace[1290107663] 'applied index is now lower than readState.Index' (duration: 492.584062ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:09:26.622963Z","caller":"traceutil/trace.go:171","msg":"trace[282602913] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"241.684265ms","start":"2026-07-02T10:09:26.381257Z","end":"2026-07-02T10:09:26.622942Z","steps":["trace[282602913] 'process raft request' (duration: 240.891341ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:09:26.686287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.870565ms","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-07-02T10:09:26.686378Z","caller":"traceutil/trace.go:171","msg":"trace[1950318214] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1250; }","duration":"705.000898ms","start":"2026-07-02T10:09:25.981354Z","end":"2026-07-02T10:09:26.686355Z","steps":["trace[1950318214] 'agreement among raft nodes before linearized reading' (duration: 641.50695ms)","trace[1950318214] 'range keys from in-memory index tree' (duration: 63.365615ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:09:26.686425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:09:25.981337Z","time spent":"705.07832ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-02T10:09:26.686751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.215503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T10:09:26.686785Z","caller":"traceutil/trace.go:171","msg":"trace[414682540] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1251; }","duration":"682.276094ms","start":"2026-07-02T10:09:26.004499Z","end":"2026-07-02T10:09:26.686775Z","steps":["trace[414682540] 'agreement among raft nodes before linearized reading' (duration: 682.195632ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:09:26.686815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:09:26.004485Z","time spent":"682.322535ms","remote":"127.0.0.1:33568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":29,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"info","ts":"2026-07-02T10:09:26.687216Z","caller":"traceutil/trace.go:171","msg":"trace[1889248220] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"249.251969ms","start":"2026-07-02T10:09:26.437951Z","end":"2026-07-02T10:09:26.687203Z","steps":["trace[1889248220] 'process raft request' (duration: 239.562605ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:09:26.687398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.734792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:09:26.68744Z","caller":"traceutil/trace.go:171","msg":"trace[685102161] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1251; }","duration":"315.781893ms","start":"2026-07-02T10:09:26.371646Z","end":"2026-07-02T10:09:26.687428Z","steps":["trace[685102161] 'agreement among raft nodes before linearized reading' (duration: 315.717852ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:09:26.687474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:09:26.371614Z","time spent":"315.851476ms","remote":"127.0.0.1:51268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:09:26.687621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.937313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:09:26.687654Z","caller":"traceutil/trace.go:171","msg":"trace[511272082] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1251; }","duration":"437.968303ms","start":"2026-07-02T10:09:26.249677Z","end":"2026-07-02T10:09:26.687645Z","steps":["trace[511272082] 'agreement among raft nodes before linearized reading' (duration: 437.923322ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:09:26.687681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:09:26.249615Z","time spent":"438.060148ms","remote":"127.0.0.1:33218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T10:09:26.687937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.096462ms","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-07-02T10:09:26.687974Z","caller":"traceutil/trace.go:171","msg":"trace[1970787618] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1251; }","duration":"555.169134ms","start":"2026-07-02T10:09:26.132796Z","end":"2026-07-02T10:09:26.687965Z","steps":["trace[1970787618] 'agreement among raft nodes before linearized reading' (duration: 555.054631ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:09:26.688002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:09:26.132776Z","time spent":"555.218916ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-02T10:09:27.652125Z","caller":"traceutil/trace.go:171","msg":"trace[1637637100] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"119.876765ms","start":"2026-07-02T10:09:27.53222Z","end":"2026-07-02T10:09:27.652097Z","steps":["trace[1637637100] 'process raft request' (duration: 119.816643ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:09:27.652518Z","caller":"traceutil/trace.go:171","msg":"trace[346000343] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"121.825222ms","start":"2026-07-02T10:09:27.530671Z","end":"2026-07-02T10:09:27.652496Z","steps":["trace[346000343] 'process raft request' (duration: 97.7746ms)","trace[346000343] 'compare' (duration: 23.465835ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:09:38.054682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.029885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:09:38.054749Z","caller":"traceutil/trace.go:171","msg":"trace[616227891] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1334; }","duration":"123.150248ms","start":"2026-07-02T10:09:37.931586Z","end":"2026-07-02T10:09:38.054736Z","steps":["trace[616227891] 'range keys from in-memory index tree' (duration: 122.938642ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:09:38.536283Z","caller":"traceutil/trace.go:171","msg":"trace[1773619480] linearizableReadLoop","detail":"{readStateIndex:1393; appliedIndex:1392; }","duration":"480.560672ms","start":"2026-07-02T10:09:38.055695Z","end":"2026-07-02T10:09:38.536256Z","steps":["trace[1773619480] 'read index received' (duration: 480.321684ms)","trace[1773619480] 'applied index is now lower than readState.Index' (duration: 237.758µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:09:38.536605Z","caller":"traceutil/trace.go:171","msg":"trace[1018143942] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"572.65588ms","start":"2026-07-02T10:09:37.963932Z","end":"2026-07-02T10:09:38.536588Z","steps":["trace[1018143942] 'process raft request' (duration: 572.156035ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:09:38.536734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:09:37.963909Z","time spent":"572.742111ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:09:38.536962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.266361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:09:38.537015Z","caller":"traceutil/trace.go:171","msg":"trace[1458456957] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1335; }","duration":"481.353274ms","start":"2026-07-02T10:09:38.055647Z","end":"2026-07-02T10:09:38.537001Z","steps":["trace[1458456957] 'agreement among raft nodes before linearized reading' (duration: 481.276081ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:09:38.537055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:09:38.055629Z","time spent":"481.417185ms","remote":"127.0.0.1:33220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T10:09:38.537384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.642765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-07-02T10:09:38.537478Z","caller":"traceutil/trace.go:171","msg":"trace[611732046] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1335; }","duration":"223.81348ms","start":"2026-07-02T10:09:38.313641Z","end":"2026-07-02T10:09:38.537454Z","steps":["trace[611732046] 'agreement among raft nodes before linearized reading' (duration: 223.540281ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:10:20.757119Z","caller":"traceutil/trace.go:171","msg":"trace[1949469733] linearizableReadLoop","detail":"{readStateIndex:1595; appliedIndex:1594; }","duration":"110.549123ms","start":"2026-07-02T10:10:20.64655Z","end":"2026-07-02T10:10:20.7571Z","steps":["trace[1949469733] 'read index received' (duration: 29.189679ms)","trace[1949469733] 'applied index is now lower than readState.Index' (duration: 81.357594ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:10:20.757627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.049426ms","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:535"} {"level":"info","ts":"2026-07-02T10:10:20.757657Z","caller":"traceutil/trace.go:171","msg":"trace[309810620] transaction","detail":"{read_only:false; response_revision:1528; number_of_response:1; }","duration":"116.443478ms","start":"2026-07-02T10:10:20.6406Z","end":"2026-07-02T10:10:20.757043Z","steps":["trace[309810620] 'process raft request' (duration: 35.137776ms)","trace[309810620] 'compare' (duration: 81.128938ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:10:20.757702Z","caller":"traceutil/trace.go:171","msg":"trace[199714581] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1529; }","duration":"111.244582ms","start":"2026-07-02T10:10:20.646439Z","end":"2026-07-02T10:10:20.757683Z","steps":["trace[199714581] 'agreement among raft nodes before linearized reading' (duration: 110.82424ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:10:22.56546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.729407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:10:22.565544Z","caller":"traceutil/trace.go:171","msg":"trace[555764295] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1538; }","duration":"142.882252ms","start":"2026-07-02T10:10:22.422642Z","end":"2026-07-02T10:10:22.565525Z","steps":["trace[555764295] 'count revisions from in-memory index tree' (duration: 142.608754ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:10:23.273583Z","caller":"traceutil/trace.go:171","msg":"trace[1956782596] transaction","detail":"{read_only:false; response_revision:1542; number_of_response:1; }","duration":"111.84749ms","start":"2026-07-02T10:10:23.161709Z","end":"2026-07-02T10:10:23.273557Z","steps":["trace[1956782596] 'process raft request' (duration: 111.602813ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:10:25.489132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.457388ms","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-07-02T10:10:25.489227Z","caller":"traceutil/trace.go:171","msg":"trace[658084563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1550; }","duration":"210.598662ms","start":"2026-07-02T10:10:25.278608Z","end":"2026-07-02T10:10:25.489206Z","steps":["trace[658084563] 'range keys from in-memory index tree' (duration: 210.270743ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:10:25.919663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.482812ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-02T10:10:25.919829Z","caller":"traceutil/trace.go:171","msg":"trace[818100321] linearizableReadLoop","detail":"{readStateIndex:1619; appliedIndex:1618; }","duration":"104.935634ms","start":"2026-07-02T10:10:25.814878Z","end":"2026-07-02T10:10:25.919814Z","steps":["trace[818100321] 'read index received' (duration: 71.171µs)","trace[818100321] 'applied index is now lower than readState.Index' (duration: 104.863073ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:10:25.920018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.126669ms","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:535"} {"level":"info","ts":"2026-07-02T10:10:25.920082Z","caller":"traceutil/trace.go:171","msg":"trace[808833916] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1551; }","duration":"105.241614ms","start":"2026-07-02T10:10:25.814824Z","end":"2026-07-02T10:10:25.920065Z","steps":["trace[808833916] 'agreement among raft nodes before linearized reading' (duration: 105.048238ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:11.877499Z","caller":"traceutil/trace.go:171","msg":"trace[1966580023] transaction","detail":"{read_only:false; response_revision:2311; number_of_response:1; }","duration":"541.270919ms","start":"2026-07-02T10:13:11.3362Z","end":"2026-07-02T10:13:11.877471Z","steps":["trace[1966580023] 'process raft request' (duration: 541.139786ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:11.877639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:11.336182Z","time spent":"541.391293ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:13:11.886032Z","caller":"traceutil/trace.go:171","msg":"trace[328532917] transaction","detail":"{read_only:false; response_revision:2312; number_of_response:1; }","duration":"292.983827ms","start":"2026-07-02T10:13:11.593026Z","end":"2026-07-02T10:13:11.88601Z","steps":["trace[328532917] 'process raft request' (duration: 292.848204ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:17.076809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.453938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-02T10:13:17.076882Z","caller":"traceutil/trace.go:171","msg":"trace[1113328664] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2334; }","duration":"102.593021ms","start":"2026-07-02T10:13:16.974272Z","end":"2026-07-02T10:13:17.076865Z","steps":["trace[1113328664] 'range keys from in-memory index tree' (duration: 102.177489ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:17.076931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.509382ms","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-07-02T10:13:17.077044Z","caller":"traceutil/trace.go:171","msg":"trace[989579998] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2334; }","duration":"101.679726ms","start":"2026-07-02T10:13:16.975337Z","end":"2026-07-02T10:13:17.077016Z","steps":["trace[989579998] 'range keys from in-memory index tree' (duration: 101.303405ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:17.796376Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9000900299922470962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:13:18.296662Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9000900299922470962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:13:18.797682Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9000900299922470962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:13:19.298692Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9000900299922470962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:13:19.800006Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9000900299922470962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:13:19.931282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000152837s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-02T10:13:19.931368Z","caller":"traceutil/trace.go:171","msg":"trace[1978511039] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000278009s","start":"2026-07-02T10:13:17.931069Z","end":"2026-07-02T10:13:19.931347Z","steps":["trace[1978511039] 'agreement among raft nodes before linearized reading' (duration: 2.000177147s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:19.931467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:17.93105Z","time spent":"2.000404883s","remote":"127.0.0.1:33218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/02 10:13:19 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-02T10:13:20.301137Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9000900299922470962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:13:20.80214Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9000900299922470962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:13:21.302761Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9000900299922470962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:13:21.802933Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9000900299922470962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:13:21.931947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000359681s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-02T10:13:21.932005Z","caller":"traceutil/trace.go:171","msg":"trace[1771310627] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000481265s","start":"2026-07-02T10:13:19.93151Z","end":"2026-07-02T10:13:21.931992Z","steps":["trace[1771310627] 'agreement among raft nodes before linearized reading' (duration: 2.000398772s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:21.932035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:19.931488Z","time spent":"2.000540516s","remote":"127.0.0.1:33220","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-07-02T10:13:22.080321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:17.081797Z","time spent":"4.998514505s","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/07/02 10:13:22 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-02T10:13:22.080469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:17.08173Z","time spent":"4.99873533s","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/07/02 10:13:22 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-02T10:13:22.303726Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9000900299922470962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:13:22.804447Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9000900299922470962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:13:22.906064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:17.90763Z","time spent":"4.998426412s","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/07/02 10:13:22 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-02T10:13:23.15651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999434302s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-02T10:13:23.156602Z","caller":"traceutil/trace.go:171","msg":"trace[855794004] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.999573135s","start":"2026-07-02T10:13:18.157009Z","end":"2026-07-02T10:13:23.156582Z","steps":["trace[855794004] 'agreement among raft nodes before linearized reading' (duration: 4.999463231s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:23.156779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:18.156992Z","time spent":"4.99977336s","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} 2026/07/02 10:13:23 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-02T10:13:23.304742Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9000900299922470962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:13:23.80517Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9000900299922470962,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:13:23.939127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999951399s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-02T10:13:23.939209Z","caller":"traceutil/trace.go:171","msg":"trace[75642094] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000073861s","start":"2026-07-02T10:13:21.939116Z","end":"2026-07-02T10:13:23.93919Z","steps":["trace[75642094] 'agreement among raft nodes before linearized reading' (duration: 1.999969178s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:23.939381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:21.939103Z","time spent":"2.000198654s","remote":"127.0.0.1:33218","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-07-02T10:13:24.081687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:17.081295Z","time spent":"7.000384118s","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-07-02T10:13:24.295923Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"} {"level":"warn","ts":"2026-07-02T10:13:24.296142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.000512741s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-07-02T10:13:24.296201Z","caller":"traceutil/trace.go:171","msg":"trace[44392826] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; }","duration":"7.000628994s","start":"2026-07-02T10:13:17.295551Z","end":"2026-07-02T10:13:24.29618Z","steps":["trace[44392826] 'agreement among raft nodes before linearized reading' (duration: 7.000542832s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:24.296247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:17.295533Z","time spent":"7.000703396s","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-02T10:13:24.796551Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9000900299922470971,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:13:24.9324Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"7.850946746s","expected-duration":"1s"} {"level":"info","ts":"2026-07-02T10:13:24.972181Z","caller":"traceutil/trace.go:171","msg":"trace[946498069] transaction","detail":"{read_only:false; response_revision:2339; number_of_response:1; }","duration":"6.677455743s","start":"2026-07-02T10:13:18.294696Z","end":"2026-07-02T10:13:24.972152Z","steps":["trace[946498069] 'process raft request' (duration: 6.677315149s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:24.972247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:21.935352Z","time spent":"3.036891798s","remote":"127.0.0.1:33284","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-02T10:13:24.972335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:18.294674Z","time spent":"6.677580328s","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:13:24.972842Z","caller":"traceutil/trace.go:171","msg":"trace[2055892450] linearizableReadLoop","detail":"{readStateIndex:2443; appliedIndex:2436; }","duration":"676.781014ms","start":"2026-07-02T10:13:24.296038Z","end":"2026-07-02T10:13:24.972819Z","steps":["trace[2055892450] 'read index received' (duration: 636.814363ms)","trace[2055892450] 'applied index is now lower than readState.Index' (duration: 39.96544ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:13:24.97299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.032496975s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T10:13:24.972992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.228916551s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T10:13:24.973013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.505329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-02T10:13:24.973032Z","caller":"traceutil/trace.go:171","msg":"trace[423088286] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2340; }","duration":"1.032577146s","start":"2026-07-02T10:13:23.940441Z","end":"2026-07-02T10:13:24.973018Z","steps":["trace[423088286] 'agreement among raft nodes before linearized reading' (duration: 1.032512364s)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:24.973037Z","caller":"traceutil/trace.go:171","msg":"trace[1813695372] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:2340; }","duration":"1.229013372s","start":"2026-07-02T10:13:23.744012Z","end":"2026-07-02T10:13:24.973025Z","steps":["trace[1813695372] 'agreement among raft nodes before linearized reading' (duration: 1.228897949s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:24.973024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.741617556s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T10:13:24.973066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:23.940418Z","time spent":"1.032641208s","remote":"127.0.0.1:33220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-02T10:13:24.973071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:23.743982Z","time spent":"1.229081234s","remote":"127.0.0.1:33360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"info","ts":"2026-07-02T10:13:24.973088Z","caller":"traceutil/trace.go:171","msg":"trace[774071926] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:2340; }","duration":"2.74172745s","start":"2026-07-02T10:13:22.231345Z","end":"2026-07-02T10:13:24.973072Z","steps":["trace[774071926] 'agreement among raft nodes before linearized reading' (duration: 2.741526175s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:24.973139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:22.231325Z","time spent":"2.741799461s","remote":"127.0.0.1:33346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"info","ts":"2026-07-02T10:13:24.973185Z","caller":"traceutil/trace.go:171","msg":"trace[941648206] transaction","detail":"{read_only:false; response_revision:2340; number_of_response:1; }","duration":"2.563435316s","start":"2026-07-02T10:13:22.409739Z","end":"2026-07-02T10:13:24.973175Z","steps":["trace[941648206] 'process raft request' (duration: 2.562451909s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:24.973245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:22.409714Z","time spent":"2.563496278s","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:13:24.973337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.23432ms","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-07-02T10:13:24.97332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.013427799s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T10:13:24.973351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.099420337s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:13:24.97337Z","caller":"traceutil/trace.go:171","msg":"trace[750011410] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2340; }","duration":"890.303993ms","start":"2026-07-02T10:13:24.083056Z","end":"2026-07-02T10:13:24.97336Z","steps":["trace[750011410] 'agreement among raft nodes before linearized reading' (duration: 890.257112ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:24.973385Z","caller":"traceutil/trace.go:171","msg":"trace[1360311399] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2340; }","duration":"3.099496759s","start":"2026-07-02T10:13:21.873879Z","end":"2026-07-02T10:13:24.973375Z","steps":["trace[1360311399] 'agreement among raft nodes before linearized reading' (duration: 3.099441898s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:24.973401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:24.083038Z","time spent":"890.354184ms","remote":"127.0.0.1:33452","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-07-02T10:13:24.973426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:21.873859Z","time spent":"3.099556751s","remote":"127.0.0.1:51280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:13:24.973436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.569117453s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-02T10:13:24.973511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.309152539s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T10:13:24.973492Z","caller":"traceutil/trace.go:171","msg":"trace[449153294] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:2340; }","duration":"1.569209576s","start":"2026-07-02T10:13:23.404262Z","end":"2026-07-02T10:13:24.973472Z","steps":["trace[449153294] 'agreement among raft nodes before linearized reading' (duration: 1.569123083s)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:24.973562Z","caller":"traceutil/trace.go:171","msg":"trace[2145615171] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:2340; }","duration":"3.309244831s","start":"2026-07-02T10:13:21.664306Z","end":"2026-07-02T10:13:24.97355Z","steps":["trace[2145615171] 'agreement among raft nodes before linearized reading' (duration: 3.309163249s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:24.973593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:23.404242Z","time spent":"1.569324719s","remote":"127.0.0.1:49818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:13:24.973605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:21.664286Z","time spent":"3.309307313s","remote":"127.0.0.1:33320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":29,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:13:24.97364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.061372821s","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:535"} {"level":"info","ts":"2026-07-02T10:13:24.973672Z","caller":"traceutil/trace.go:171","msg":"trace[1769500653] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2340; }","duration":"3.061428983s","start":"2026-07-02T10:13:21.912234Z","end":"2026-07-02T10:13:24.973663Z","steps":["trace[1769500653] 'agreement among raft nodes before linearized reading' (duration: 3.06132413s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:24.97375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:21.912219Z","time spent":"3.061523745s","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-02T10:13:24.973774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.614584389s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-07-02T10:13:24.973836Z","caller":"traceutil/trace.go:171","msg":"trace[1843266525] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2340; }","duration":"5.614705583s","start":"2026-07-02T10:13:19.359116Z","end":"2026-07-02T10:13:24.973822Z","steps":["trace[1843266525] 'agreement among raft nodes before linearized reading' (duration: 5.614482346s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:24.973874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:19.359092Z","time spent":"5.614775845s","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-02T10:13:24.973919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.065528363s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:550"} {"level":"warn","ts":"2026-07-02T10:13:24.973914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.540554841s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-02T10:13:24.973981Z","caller":"traceutil/trace.go:171","msg":"trace[1981978225] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:2340; }","duration":"2.065625627s","start":"2026-07-02T10:13:22.90834Z","end":"2026-07-02T10:13:24.973966Z","steps":["trace[1981978225] 'agreement among raft nodes before linearized reading' (duration: 2.065523914s)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:24.973984Z","caller":"traceutil/trace.go:171","msg":"trace[464294525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2340; }","duration":"6.540651483s","start":"2026-07-02T10:13:18.433319Z","end":"2026-07-02T10:13:24.973971Z","steps":["trace[464294525] 'agreement among raft nodes before linearized reading' (duration: 6.54051166s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:24.974023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.371780495s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.199\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-02T10:13:24.974034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:22.908323Z","time spent":"2.065698408s","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":572,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-07-02T10:13:24.974036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:18.433299Z","time spent":"6.540725145s","remote":"127.0.0.1:33452","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-07-02T10:13:24.974066Z","caller":"traceutil/trace.go:171","msg":"trace[1378663779] range","detail":"{range_begin:/registry/masterleases/199.19.213.199; range_end:; response_count:1; response_revision:2340; }","duration":"4.371821997s","start":"2026-07-02T10:13:20.602233Z","end":"2026-07-02T10:13:24.974055Z","steps":["trace[1378663779] 'agreement among raft nodes before linearized reading' (duration: 4.371726674s)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:24.973065Z","caller":"traceutil/trace.go:171","msg":"trace[1979585974] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2340; }","duration":"890.60594ms","start":"2026-07-02T10:13:24.082446Z","end":"2026-07-02T10:13:24.973052Z","steps":["trace[1979585974] 'agreement among raft nodes before linearized reading' (duration: 890.457376ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:24.974122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:24.082419Z","time spent":"891.691922ms","remote":"127.0.0.1:33452","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-07-02T10:13:24.974195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.937965133s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"warn","ts":"2026-07-02T10:13:24.974208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:20.602163Z","time spent":"4.372037173s","remote":"127.0.0.1:33232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.199\" "} {"level":"info","ts":"2026-07-02T10:13:24.974239Z","caller":"traceutil/trace.go:171","msg":"trace[780931627] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2340; }","duration":"6.938033674s","start":"2026-07-02T10:13:18.036196Z","end":"2026-07-02T10:13:24.97423Z","steps":["trace[780931627] 'agreement among raft nodes before linearized reading' (duration: 6.937931201s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:24.974284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:18.036182Z","time spent":"6.938084946s","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":552,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-07-02T10:13:24.973423Z","caller":"traceutil/trace.go:171","msg":"trace[1548681385] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:2340; }","duration":"4.013530672s","start":"2026-07-02T10:13:20.959844Z","end":"2026-07-02T10:13:24.973374Z","steps":["trace[1548681385] 'agreement among raft nodes before linearized reading' (duration: 4.013308906s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:24.974359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:20.959778Z","time spent":"4.014561862s","remote":"127.0.0.1:33434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:13:24.974415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.20939821s","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:525"} {"level":"info","ts":"2026-07-02T10:13:24.975109Z","caller":"traceutil/trace.go:171","msg":"trace[924177899] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2340; }","duration":"7.21013866s","start":"2026-07-02T10:13:17.76495Z","end":"2026-07-02T10:13:24.975089Z","steps":["trace[924177899] 'agreement among raft nodes before linearized reading' (duration: 7.207952628s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:24.975301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:17.764927Z","time spent":"7.210304316s","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":547,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-02T10:13:25.329328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.102848ms","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-07-02T10:13:25.329481Z","caller":"traceutil/trace.go:171","msg":"trace[1128215277] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2340; }","duration":"166.273403ms","start":"2026-07-02T10:13:25.163176Z","end":"2026-07-02T10:13:25.32945Z","steps":["trace[1128215277] 'range keys from in-memory index tree' (duration: 166.082978ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:25.347593Z","caller":"traceutil/trace.go:171","msg":"trace[1915693234] transaction","detail":"{read_only:false; response_revision:2341; number_of_response:1; }","duration":"373.902135ms","start":"2026-07-02T10:13:24.973676Z","end":"2026-07-02T10:13:25.347578Z","steps":["trace[1915693234] 'process raft request' (duration: 373.741641ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:25.34769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:24.973621Z","time spent":"374.018899ms","remote":"127.0.0.1:33284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T10:13:25.515255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:24.975607Z","time spent":"539.639903ms","remote":"127.0.0.1:33232","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-02T10:13:25.515502Z","caller":"traceutil/trace.go:171","msg":"trace[659158960] transaction","detail":"{read_only:false; response_revision:2343; number_of_response:1; }","duration":"534.96969ms","start":"2026-07-02T10:13:24.980509Z","end":"2026-07-02T10:13:25.515479Z","steps":["trace[659158960] 'process raft request' (duration: 534.758614ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:25.515676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:24.980502Z","time spent":"535.092245ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:13:25.515774Z","caller":"traceutil/trace.go:171","msg":"trace[1039022130] transaction","detail":"{read_only:false; response_revision:2346; number_of_response:1; }","duration":"535.147178ms","start":"2026-07-02T10:13:24.980605Z","end":"2026-07-02T10:13:25.515752Z","steps":["trace[1039022130] 'process raft request' (duration: 534.757266ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:25.51583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.145436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:550"} {"level":"warn","ts":"2026-07-02T10:13:25.515892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:24.980599Z","time spent":"535.219399ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:13:25.515913Z","caller":"traceutil/trace.go:171","msg":"trace[1709036026] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:2348; }","duration":"535.253029ms","start":"2026-07-02T10:13:24.980635Z","end":"2026-07-02T10:13:25.515888Z","steps":["trace[1709036026] 'agreement among raft nodes before linearized reading' (duration: 534.93097ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:25.515989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:24.980628Z","time spent":"535.339642ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":572,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-07-02T10:13:25.516061Z","caller":"traceutil/trace.go:171","msg":"trace[814383192] transaction","detail":"{read_only:false; response_revision:2344; number_of_response:1; }","duration":"535.494076ms","start":"2026-07-02T10:13:24.980555Z","end":"2026-07-02T10:13:25.516049Z","steps":["trace[814383192] 'process raft request' (duration: 534.747275ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:25.516119Z","caller":"traceutil/trace.go:171","msg":"trace[860979391] transaction","detail":"{read_only:false; response_revision:2347; number_of_response:1; }","duration":"535.255459ms","start":"2026-07-02T10:13:24.980851Z","end":"2026-07-02T10:13:25.516106Z","steps":["trace[860979391] 'process raft request' (duration: 534.540419ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:25.516124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:24.980549Z","time spent":"535.543648ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:13:25.516205Z","caller":"traceutil/trace.go:171","msg":"trace[695810547] transaction","detail":"{read_only:false; response_revision:2345; number_of_response:1; }","duration":"535.62372ms","start":"2026-07-02T10:13:24.98057Z","end":"2026-07-02T10:13:25.516193Z","steps":["trace[695810547] 'process raft request' (duration: 534.762686ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:25.516239Z","caller":"traceutil/trace.go:171","msg":"trace[1098325412] transaction","detail":"{read_only:false; response_revision:2348; number_of_response:1; }","duration":"535.166297ms","start":"2026-07-02T10:13:24.981064Z","end":"2026-07-02T10:13:25.516231Z","steps":["trace[1098325412] 'process raft request' (duration: 534.358444ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:25.516262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:24.980551Z","time spent":"535.684622ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:13:25.516288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:24.981025Z","time spent":"535.237409ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:13:25.516347Z","caller":"traceutil/trace.go:171","msg":"trace[385784248] transaction","detail":"{read_only:false; response_revision:2342; number_of_response:1; }","duration":"535.920648ms","start":"2026-07-02T10:13:24.980415Z","end":"2026-07-02T10:13:25.516336Z","steps":["trace[385784248] 'process raft request' (duration: 534.729214ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:25.516205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:24.98084Z","time spent":"535.30806ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:13:25.516428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:24.980395Z","time spent":"536.006291ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:13:25.515507Z","caller":"traceutil/trace.go:171","msg":"trace[963383960] linearizableReadLoop","detail":"{readStateIndex:2450; appliedIndex:2443; }","duration":"534.809956ms","start":"2026-07-02T10:13:24.980671Z","end":"2026-07-02T10:13:25.515481Z","steps":["trace[963383960] 'read index received' (duration: 366.761284ms)","trace[963383960] 'applied index is now lower than readState.Index' (duration: 168.047512ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:13:25.529957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.803566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:13:25.53001Z","caller":"traceutil/trace.go:171","msg":"trace[2145760689] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2349; }","duration":"546.882408ms","start":"2026-07-02T10:13:24.983115Z","end":"2026-07-02T10:13:25.529998Z","steps":["trace[2145760689] 'agreement among raft nodes before linearized reading' (duration: 546.777265ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:25.530019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.33303ms","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-07-02T10:13:25.530038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:24.983078Z","time spent":"546.954771ms","remote":"127.0.0.1:33218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-02T10:13:25.530051Z","caller":"traceutil/trace.go:171","msg":"trace[33680218] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2349; }","duration":"367.407191ms","start":"2026-07-02T10:13:25.162635Z","end":"2026-07-02T10:13:25.530042Z","steps":["trace[33680218] 'agreement among raft nodes before linearized reading' (duration: 367.304578ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:25.530075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:25.162614Z","time spent":"367.455364ms","remote":"127.0.0.1:33452","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-07-02T10:13:25.530137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.615991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18be7169da43f9a4\" ","response":"range_response_count:1 size:774"} {"level":"info","ts":"2026-07-02T10:13:25.530211Z","caller":"traceutil/trace.go:171","msg":"trace[598679126] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18be7169da43f9a4; range_end:; response_count:1; response_revision:2349; }","duration":"179.720043ms","start":"2026-07-02T10:13:25.350479Z","end":"2026-07-02T10:13:25.530199Z","steps":["trace[598679126] 'agreement among raft nodes before linearized reading' (duration: 179.439695ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:26.204642Z","caller":"traceutil/trace.go:171","msg":"trace[27501249] transaction","detail":"{read_only:false; response_revision:2352; number_of_response:1; }","duration":"116.073213ms","start":"2026-07-02T10:13:26.088546Z","end":"2026-07-02T10:13:26.204619Z","steps":["trace[27501249] 'process raft request' (duration: 115.907229ms)"],"step_count":1} 2026/07/02 10:13:27 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-02T10:13:27.809077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.178564ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T10:13:27.809238Z","caller":"traceutil/trace.go:171","msg":"trace[38110124] transaction","detail":"{read_only:false; response_revision:2355; number_of_response:1; }","duration":"258.996415ms","start":"2026-07-02T10:13:27.550215Z","end":"2026-07-02T10:13:27.809212Z","steps":["trace[38110124] 'process raft request' (duration: 100.575974ms)","trace[38110124] 'compare' (duration: 157.951168ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:13:27.883855Z","caller":"traceutil/trace.go:171","msg":"trace[398962190] transaction","detail":"{read_only:false; response_revision:2357; number_of_response:1; }","duration":"333.365349ms","start":"2026-07-02T10:13:27.55047Z","end":"2026-07-02T10:13:27.883835Z","steps":["trace[398962190] 'process raft request' (duration: 333.312308ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:27.883874Z","caller":"traceutil/trace.go:171","msg":"trace[1682531886] transaction","detail":"{read_only:false; response_revision:2356; number_of_response:1; }","duration":"333.473343ms","start":"2026-07-02T10:13:27.550379Z","end":"2026-07-02T10:13:27.883852Z","steps":["trace[1682531886] 'process raft request' (duration: 333.293578ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:27.883972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:27.550449Z","time spent":"333.464131ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:13:27.883977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:27.550352Z","time spent":"333.577644ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:13:27.884195Z","caller":"traceutil/trace.go:171","msg":"trace[1861836900] transaction","detail":"{read_only:false; response_revision:2358; number_of_response:1; }","duration":"332.833054ms","start":"2026-07-02T10:13:27.55135Z","end":"2026-07-02T10:13:27.884183Z","steps":["trace[1861836900] 'process raft request' (duration: 332.463183ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:27.884233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:27.551336Z","time spent":"332.875646ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":516,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:13:27.88416Z","caller":"traceutil/trace.go:171","msg":"trace[296882524] linearizableReadLoop","detail":"{readStateIndex:2463; appliedIndex:2459; }","duration":"313.832356ms","start":"2026-07-02T10:13:27.570293Z","end":"2026-07-02T10:13:27.884125Z","steps":["trace[296882524] 'read index received' (duration: 80.525488ms)","trace[296882524] 'applied index is now lower than readState.Index' (duration: 233.304458ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:13:27.884997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.704031ms","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-07-02T10:13:27.88505Z","caller":"traceutil/trace.go:171","msg":"trace[1904129458] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2358; }","duration":"314.786373ms","start":"2026-07-02T10:13:27.570251Z","end":"2026-07-02T10:13:27.885037Z","steps":["trace[1904129458] 'agreement among raft nodes before linearized reading' (duration: 314.018211ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:27.885085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:27.570238Z","time spent":"314.838875ms","remote":"127.0.0.1:33452","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-07-02T10:13:28.035158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.721917ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T10:13:28.035283Z","caller":"traceutil/trace.go:171","msg":"trace[946858278] linearizableReadLoop","detail":"{readStateIndex:2464; appliedIndex:2463; }","duration":"105.807132ms","start":"2026-07-02T10:13:27.929445Z","end":"2026-07-02T10:13:28.035252Z","steps":["trace[946858278] 'read index received' (duration: 3.798357ms)","trace[946858278] 'applied index is now lower than readState.Index' (duration: 102.007355ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:13:28.035323Z","caller":"traceutil/trace.go:171","msg":"trace[1261937153] transaction","detail":"{read_only:false; response_revision:2359; number_of_response:1; }","duration":"146.515295ms","start":"2026-07-02T10:13:27.888768Z","end":"2026-07-02T10:13:28.035284Z","steps":["trace[1261937153] 'process raft request' (duration: 44.571441ms)","trace[1261937153] 'compare' (duration: 101.508392ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:13:28.035568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.116601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:13:28.035687Z","caller":"traceutil/trace.go:171","msg":"trace[961771268] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2359; }","duration":"106.283846ms","start":"2026-07-02T10:13:27.929386Z","end":"2026-07-02T10:13:28.03567Z","steps":["trace[961771268] 'agreement among raft nodes before linearized reading' (duration: 105.934257ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:28.602193Z","caller":"traceutil/trace.go:171","msg":"trace[1429211681] transaction","detail":"{read_only:false; response_revision:2361; number_of_response:1; }","duration":"122.605048ms","start":"2026-07-02T10:13:28.47956Z","end":"2026-07-02T10:13:28.602165Z","steps":["trace[1429211681] 'process raft request' (duration: 122.443124ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:28.87526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.088887ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T10:13:28.875373Z","caller":"traceutil/trace.go:171","msg":"trace[1052281029] transaction","detail":"{read_only:false; response_revision:2362; number_of_response:1; }","duration":"266.533729ms","start":"2026-07-02T10:13:28.608816Z","end":"2026-07-02T10:13:28.87535Z","steps":["trace[1052281029] 'process raft request' (duration: 47.267737ms)","trace[1052281029] 'compare' (duration: 218.888932ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:13:28.895125Z","caller":"traceutil/trace.go:171","msg":"trace[966026992] transaction","detail":"{read_only:false; response_revision:2364; number_of_response:1; }","duration":"281.821501ms","start":"2026-07-02T10:13:28.613281Z","end":"2026-07-02T10:13:28.895102Z","steps":["trace[966026992] 'process raft request' (duration: 281.747849ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:28.895207Z","caller":"traceutil/trace.go:171","msg":"trace[156848701] transaction","detail":"{read_only:false; response_revision:2363; number_of_response:1; }","duration":"286.271027ms","start":"2026-07-02T10:13:28.608885Z","end":"2026-07-02T10:13:28.895156Z","steps":["trace[156848701] 'process raft request' (duration: 285.946838ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:29.052891Z","caller":"traceutil/trace.go:171","msg":"trace[366049141] linearizableReadLoop","detail":"{readStateIndex:2470; appliedIndex:2469; }","duration":"121.587599ms","start":"2026-07-02T10:13:28.931281Z","end":"2026-07-02T10:13:29.052868Z","steps":["trace[366049141] 'read index received' (duration: 101.189852ms)","trace[366049141] 'applied index is now lower than readState.Index' (duration: 20.396797ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:13:29.053033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.734994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:13:29.053063Z","caller":"traceutil/trace.go:171","msg":"trace[655344751] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2365; }","duration":"121.822335ms","start":"2026-07-02T10:13:28.931231Z","end":"2026-07-02T10:13:29.053054Z","steps":["trace[655344751] 'agreement among raft nodes before linearized reading' (duration: 121.719822ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:29.053246Z","caller":"traceutil/trace.go:171","msg":"trace[1700447795] transaction","detail":"{read_only:false; response_revision:2365; number_of_response:1; }","duration":"146.227426ms","start":"2026-07-02T10:13:28.907007Z","end":"2026-07-02T10:13:29.053234Z","steps":["trace[1700447795] 'process raft request' (duration: 125.431348ms)","trace[1700447795] 'compare' (duration: 20.060927ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:13:29.998102Z","caller":"traceutil/trace.go:171","msg":"trace[1339743259] transaction","detail":"{read_only:false; response_revision:2369; number_of_response:1; }","duration":"104.255378ms","start":"2026-07-02T10:13:29.893821Z","end":"2026-07-02T10:13:29.998077Z","steps":["trace[1339743259] 'process raft request' (duration: 104.097364ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:29.998286Z","caller":"traceutil/trace.go:171","msg":"trace[415198397] transaction","detail":"{read_only:false; response_revision:2370; number_of_response:1; }","duration":"104.176586ms","start":"2026-07-02T10:13:29.89409Z","end":"2026-07-02T10:13:29.998266Z","steps":["trace[415198397] 'process raft request' (duration: 103.9515ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:30.16749Z","caller":"traceutil/trace.go:171","msg":"trace[1435971966] transaction","detail":"{read_only:false; response_revision:2371; number_of_response:1; }","duration":"121.572969ms","start":"2026-07-02T10:13:30.045883Z","end":"2026-07-02T10:13:30.167456Z","steps":["trace[1435971966] 'process raft request' (duration: 46.822854ms)","trace[1435971966] 'compare' (duration: 74.606881ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:13:30.659603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.484537ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T10:13:30.659722Z","caller":"traceutil/trace.go:171","msg":"trace[745546963] linearizableReadLoop","detail":"{readStateIndex:2477; appliedIndex:2476; }","duration":"170.527514ms","start":"2026-07-02T10:13:30.489172Z","end":"2026-07-02T10:13:30.6597Z","steps":["trace[745546963] 'read index received' (duration: 44.022µs)","trace[745546963] 'applied index is now lower than readState.Index' (duration: 170.479862ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:13:30.659797Z","caller":"traceutil/trace.go:171","msg":"trace[140986857] transaction","detail":"{read_only:false; response_revision:2372; number_of_response:1; }","duration":"404.632415ms","start":"2026-07-02T10:13:30.255154Z","end":"2026-07-02T10:13:30.659787Z","steps":["trace[140986857] 'process raft request' (duration: 194.910443ms)","trace[140986857] 'compare' (duration: 208.187569ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:13:30.65997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.837017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:13:30.660035Z","caller":"traceutil/trace.go:171","msg":"trace[1384661545] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:2372; }","duration":"103.960921ms","start":"2026-07-02T10:13:30.55606Z","end":"2026-07-02T10:13:30.66002Z","steps":["trace[1384661545] 'agreement among raft nodes before linearized reading' (duration: 103.833167ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:30.660071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.888314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-gfbfs\" ","response":"range_response_count:1 size:14021"} {"level":"info","ts":"2026-07-02T10:13:30.66013Z","caller":"traceutil/trace.go:171","msg":"trace[880091120] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-gfbfs; range_end:; response_count:1; response_revision:2372; }","duration":"170.997637ms","start":"2026-07-02T10:13:30.489117Z","end":"2026-07-02T10:13:30.660114Z","steps":["trace[880091120] 'agreement among raft nodes before linearized reading' (duration: 170.817052ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:30.660111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.93336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-07-02T10:13:30.660199Z","caller":"traceutil/trace.go:171","msg":"trace[676684449] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2372; }","duration":"139.080513ms","start":"2026-07-02T10:13:30.521097Z","end":"2026-07-02T10:13:30.660178Z","steps":["trace[676684449] 'agreement among raft nodes before linearized reading' (duration: 138.790475ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:30.660251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.073524ms","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:525"} {"level":"warn","ts":"2026-07-02T10:13:30.659903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:30.255133Z","time spent":"404.685916ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:13:30.660131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.910969ms","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:535"} {"level":"info","ts":"2026-07-02T10:13:30.660406Z","caller":"traceutil/trace.go:171","msg":"trace[1438821432] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2372; }","duration":"139.239718ms","start":"2026-07-02T10:13:30.521157Z","end":"2026-07-02T10:13:30.660397Z","steps":["trace[1438821432] 'agreement among raft nodes before linearized reading' (duration: 138.830497ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:30.660316Z","caller":"traceutil/trace.go:171","msg":"trace[1441801414] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2372; }","duration":"139.130436ms","start":"2026-07-02T10:13:30.52117Z","end":"2026-07-02T10:13:30.6603Z","steps":["trace[1441801414] 'agreement among raft nodes before linearized reading' (duration: 139.020132ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:30.660465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.348626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:13:30.660601Z","caller":"traceutil/trace.go:171","msg":"trace[1863161034] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:2372; }","duration":"136.644806ms","start":"2026-07-02T10:13:30.523915Z","end":"2026-07-02T10:13:30.66056Z","steps":["trace[1863161034] 'agreement among raft nodes before linearized reading' (duration: 136.241044ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:31.000234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.485357ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T10:13:31.000529Z","caller":"traceutil/trace.go:171","msg":"trace[1871623873] transaction","detail":"{read_only:false; response_revision:2377; number_of_response:1; }","duration":"320.051533ms","start":"2026-07-02T10:13:30.680451Z","end":"2026-07-02T10:13:31.000502Z","steps":["trace[1871623873] 'process raft request' (duration: 99.211057ms)","trace[1871623873] 'compare' (duration: 220.163688ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:13:31.00141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:30.680435Z","time spent":"320.900367ms","remote":"127.0.0.1:33232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:13:31.000625Z","caller":"traceutil/trace.go:171","msg":"trace[396981209] transaction","detail":"{read_only:false; response_revision:2378; number_of_response:1; }","duration":"267.394383ms","start":"2026-07-02T10:13:30.73321Z","end":"2026-07-02T10:13:31.000604Z","steps":["trace[396981209] 'process raft request' (duration: 267.111745ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:31.00073Z","caller":"traceutil/trace.go:171","msg":"trace[528170889] transaction","detail":"{read_only:false; response_revision:2379; number_of_response:1; }","duration":"267.29026ms","start":"2026-07-02T10:13:30.733418Z","end":"2026-07-02T10:13:31.000708Z","steps":["trace[528170889] 'process raft request' (duration: 266.977181ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:31.000968Z","caller":"traceutil/trace.go:171","msg":"trace[1575367991] transaction","detail":"{read_only:false; response_revision:2380; number_of_response:1; }","duration":"262.878116ms","start":"2026-07-02T10:13:30.738066Z","end":"2026-07-02T10:13:31.000944Z","steps":["trace[1575367991] 'process raft request' (duration: 262.582288ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:31.256156Z","caller":"traceutil/trace.go:171","msg":"trace[1211933591] transaction","detail":"{read_only:false; response_revision:2381; number_of_response:1; }","duration":"240.899904ms","start":"2026-07-02T10:13:31.015234Z","end":"2026-07-02T10:13:31.256134Z","steps":["trace[1211933591] 'process raft request' (duration: 240.753059ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:52.324525Z","caller":"traceutil/trace.go:171","msg":"trace[1635305668] transaction","detail":"{read_only:false; response_revision:2492; number_of_response:1; }","duration":"111.03521ms","start":"2026-07-02T10:13:52.213443Z","end":"2026-07-02T10:13:52.324478Z","steps":["trace[1635305668] 'process raft request' (duration: 39.94583ms)","trace[1635305668] 'compare' (duration: 70.870224ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:13:54.433081Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9000900299922471323,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T10:13:54.493873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.678944663s","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-07-02T10:13:54.493942Z","caller":"traceutil/trace.go:171","msg":"trace[1270319669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2493; }","duration":"1.679058416s","start":"2026-07-02T10:13:52.814863Z","end":"2026-07-02T10:13:54.493921Z","steps":["trace[1270319669] 'range keys from in-memory index tree' (duration: 1.678636835s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:54.493984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:52.81484Z","time spent":"1.679133409s","remote":"127.0.0.1:33452","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-07-02T10:13:54.537183Z","caller":"traceutil/trace.go:171","msg":"trace[1938111049] transaction","detail":"{read_only:false; response_revision:2494; number_of_response:1; }","duration":"809.839155ms","start":"2026-07-02T10:13:53.727273Z","end":"2026-07-02T10:13:54.537112Z","steps":["trace[1938111049] 'process raft request' (duration: 809.675451ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:54.537359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:53.727252Z","time spent":"810.020101ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:13:54.549838Z","caller":"traceutil/trace.go:171","msg":"trace[1183112358] transaction","detail":"{read_only:false; response_revision:2495; number_of_response:1; }","duration":"739.908876ms","start":"2026-07-02T10:13:53.809905Z","end":"2026-07-02T10:13:54.549814Z","steps":["trace[1183112358] 'process raft request' (duration: 739.760683ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:54.550537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:53.809877Z","time spent":"740.597706ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1768,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:13:54.550004Z","caller":"traceutil/trace.go:171","msg":"trace[1629501924] linearizableReadLoop","detail":"{readStateIndex:2605; appliedIndex:2603; }","duration":"617.631489ms","start":"2026-07-02T10:13:53.932347Z","end":"2026-07-02T10:13:54.549978Z","steps":["trace[1629501924] 'read index received' (duration: 604.698272ms)","trace[1629501924] 'applied index is now lower than readState.Index' (duration: 12.932077ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:13:54.550097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.737742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-02T10:13:54.550892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.695361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:13:54.550977Z","caller":"traceutil/trace.go:171","msg":"trace[2079063455] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2496; }","duration":"605.830466ms","start":"2026-07-02T10:13:53.945132Z","end":"2026-07-02T10:13:54.550962Z","steps":["trace[2079063455] 'agreement among raft nodes before linearized reading' (duration: 605.697952ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:54.551046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:53.94512Z","time spent":"605.913268ms","remote":"127.0.0.1:51294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-02T10:13:54.551201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.397392ms","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-07-02T10:13:54.551247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.99297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1783"} {"level":"info","ts":"2026-07-02T10:13:54.551304Z","caller":"traceutil/trace.go:171","msg":"trace[1932998353] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2496; }","duration":"338.519285ms","start":"2026-07-02T10:13:54.212738Z","end":"2026-07-02T10:13:54.551257Z","steps":["trace[1932998353] 'agreement among raft nodes before linearized reading' (duration: 338.116634ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:54.551297Z","caller":"traceutil/trace.go:171","msg":"trace[2058693719] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:2496; }","duration":"606.064392ms","start":"2026-07-02T10:13:53.945216Z","end":"2026-07-02T10:13:54.551281Z","steps":["trace[2058693719] 'agreement among raft nodes before linearized reading' (duration: 605.9885ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:54.551352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:53.945205Z","time spent":"606.139514ms","remote":"127.0.0.1:33386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":1805,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "} {"level":"warn","ts":"2026-07-02T10:13:54.551352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.618287ms","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-07-02T10:13:54.551416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:54.212718Z","time spent":"338.623408ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-02T10:13:54.551466Z","caller":"traceutil/trace.go:171","msg":"trace[1167337500] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2496; }","duration":"379.749721ms","start":"2026-07-02T10:13:54.171699Z","end":"2026-07-02T10:13:54.551449Z","steps":["trace[1167337500] 'agreement among raft nodes before linearized reading' (duration: 379.485464ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:54.551524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:54.171651Z","time spent":"379.863244ms","remote":"127.0.0.1:33452","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-07-02T10:13:54.551549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.688829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-02T10:13:54.551619Z","caller":"traceutil/trace.go:171","msg":"trace[1164097032] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2496; }","duration":"187.76379ms","start":"2026-07-02T10:13:54.363816Z","end":"2026-07-02T10:13:54.55158Z","steps":["trace[1164097032] 'agreement among raft nodes before linearized reading' (duration: 187.469032ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:54.551682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.218275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-07-02T10:13:54.551716Z","caller":"traceutil/trace.go:171","msg":"trace[1842869316] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2496; }","duration":"222.329999ms","start":"2026-07-02T10:13:54.329375Z","end":"2026-07-02T10:13:54.551705Z","steps":["trace[1842869316] 'agreement among raft nodes before linearized reading' (duration: 222.242057ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:54.551846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.426138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-02T10:13:54.551892Z","caller":"traceutil/trace.go:171","msg":"trace[1805165] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2496; }","duration":"539.493368ms","start":"2026-07-02T10:13:54.012373Z","end":"2026-07-02T10:13:54.551867Z","steps":["trace[1805165] 'agreement among raft nodes before linearized reading' (duration: 538.736067ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:54.551919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:54.012358Z","time spent":"539.554571ms","remote":"127.0.0.1:33452","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-07-02T10:13:54.550789Z","caller":"traceutil/trace.go:171","msg":"trace[1757838485] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2496; }","duration":"618.471753ms","start":"2026-07-02T10:13:53.932298Z","end":"2026-07-02T10:13:54.55077Z","steps":["trace[1757838485] 'agreement among raft nodes before linearized reading' (duration: 617.751182ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:13:54.552323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:13:53.932278Z","time spent":"620.026997ms","remote":"127.0.0.1:33218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-02T10:13:55.32738Z","caller":"traceutil/trace.go:171","msg":"trace[1357001306] transaction","detail":"{read_only:false; response_revision:2507; number_of_response:1; }","duration":"155.629322ms","start":"2026-07-02T10:13:55.171715Z","end":"2026-07-02T10:13:55.327344Z","steps":["trace[1357001306] 'process raft request' (duration: 129.36298ms)","trace[1357001306] 'compare' (duration: 25.785458ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:13:55.935158Z","caller":"traceutil/trace.go:171","msg":"trace[62328725] transaction","detail":"{read_only:false; response_revision:2513; number_of_response:1; }","duration":"123.148362ms","start":"2026-07-02T10:13:55.811985Z","end":"2026-07-02T10:13:55.935134Z","steps":["trace[62328725] 'process raft request' (duration: 123.065091ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:13:55.93517Z","caller":"traceutil/trace.go:171","msg":"trace[1089706007] transaction","detail":"{read_only:false; response_revision:2512; number_of_response:1; }","duration":"123.230925ms","start":"2026-07-02T10:13:55.811899Z","end":"2026-07-02T10:13:55.93513Z","steps":["trace[1089706007] 'process raft request' (duration: 112.624616ms)","trace[1089706007] 'compare' (duration: 10.404164ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:14:01.104171Z","caller":"traceutil/trace.go:171","msg":"trace[229662787] transaction","detail":"{read_only:false; response_revision:2539; number_of_response:1; }","duration":"132.175769ms","start":"2026-07-02T10:14:00.971953Z","end":"2026-07-02T10:14:01.104128Z","steps":["trace[229662787] 'process raft request' (duration: 104.32847ms)","trace[229662787] 'compare' (duration: 27.614772ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:14:01.104604Z","caller":"traceutil/trace.go:171","msg":"trace[1117558196] transaction","detail":"{read_only:false; response_revision:2540; number_of_response:1; }","duration":"131.406877ms","start":"2026-07-02T10:14:00.973175Z","end":"2026-07-02T10:14:01.104582Z","steps":["trace[1117558196] 'process raft request' (duration: 130.877692ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:14:11.075894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.845197ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T10:14:11.076048Z","caller":"traceutil/trace.go:171","msg":"trace[419824580] linearizableReadLoop","detail":"{readStateIndex:2699; appliedIndex:2698; }","duration":"409.688137ms","start":"2026-07-02T10:14:10.666335Z","end":"2026-07-02T10:14:11.076023Z","steps":["trace[419824580] 'read index received' (duration: 43.5298ms)","trace[419824580] 'applied index is now lower than readState.Index' (duration: 366.156727ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:14:11.076153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.809191ms","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-07-02T10:14:11.076194Z","caller":"traceutil/trace.go:171","msg":"trace[6876927] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:2585; }","duration":"409.894834ms","start":"2026-07-02T10:14:10.666293Z","end":"2026-07-02T10:14:11.076187Z","steps":["trace[6876927] 'agreement among raft nodes before linearized reading' (duration: 409.805181ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:14:11.076219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:14:10.666276Z","time spent":"409.937956ms","remote":"127.0.0.1:33370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-07-02T10:14:11.076368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.334458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-02T10:14:11.076405Z","caller":"traceutil/trace.go:171","msg":"trace[1299523829] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2585; }","duration":"292.40005ms","start":"2026-07-02T10:14:10.783994Z","end":"2026-07-02T10:14:11.076394Z","steps":["trace[1299523829] 'agreement among raft nodes before linearized reading' (duration: 292.297637ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:14:11.076422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.427923ms","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-07-02T10:14:11.076463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.907837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:14:11.076493Z","caller":"traceutil/trace.go:171","msg":"trace[637503151] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2585; }","duration":"145.957508ms","start":"2026-07-02T10:14:10.930528Z","end":"2026-07-02T10:14:11.076485Z","steps":["trace[637503151] 'agreement among raft nodes before linearized reading' (duration: 145.917217ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:14:11.076476Z","caller":"traceutil/trace.go:171","msg":"trace[626283287] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2585; }","duration":"303.515794ms","start":"2026-07-02T10:14:10.772945Z","end":"2026-07-02T10:14:11.076461Z","steps":["trace[626283287] 'agreement among raft nodes before linearized reading' (duration: 303.377971ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:14:11.076568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.521036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-02T10:14:11.076592Z","caller":"traceutil/trace.go:171","msg":"trace[1332018492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2585; }","duration":"262.584127ms","start":"2026-07-02T10:14:10.814001Z","end":"2026-07-02T10:14:11.076585Z","steps":["trace[1332018492] 'agreement among raft nodes before linearized reading' (duration: 262.524055ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:14:11.076585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:14:10.772914Z","time spent":"303.652949ms","remote":"127.0.0.1:33452","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-07-02T10:14:11.076631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.461126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-07-02T10:14:11.076671Z","caller":"traceutil/trace.go:171","msg":"trace[37063157] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2585; }","duration":"214.524358ms","start":"2026-07-02T10:14:10.862132Z","end":"2026-07-02T10:14:11.076657Z","steps":["trace[37063157] 'agreement among raft nodes before linearized reading' (duration: 214.438585ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:14:11.076699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.999126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"warn","ts":"2026-07-02T10:14:11.076363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.261918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-02T10:14:11.076755Z","caller":"traceutil/trace.go:171","msg":"trace[171815943] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2585; }","duration":"262.681631ms","start":"2026-07-02T10:14:10.814056Z","end":"2026-07-02T10:14:11.076738Z","steps":["trace[171815943] 'agreement among raft nodes before linearized reading' (duration: 262.228927ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:14:11.076717Z","caller":"traceutil/trace.go:171","msg":"trace[668663363] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2585; }","duration":"288.047067ms","start":"2026-07-02T10:14:10.788663Z","end":"2026-07-02T10:14:11.07671Z","steps":["trace[668663363] 'agreement among raft nodes before linearized reading' (duration: 287.997746ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:14:11.076808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.423148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-07-02T10:14:11.076841Z","caller":"traceutil/trace.go:171","msg":"trace[1426752901] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2585; }","duration":"323.486878ms","start":"2026-07-02T10:14:10.753344Z","end":"2026-07-02T10:14:11.076831Z","steps":["trace[1426752901] 'agreement among raft nodes before linearized reading' (duration: 323.397157ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:14:11.076868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:14:10.753326Z","time spent":"323.534741ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-07-02T10:14:11.076063Z","caller":"traceutil/trace.go:171","msg":"trace[2084437740] transaction","detail":"{read_only:false; response_revision:2585; number_of_response:1; }","duration":"428.18459ms","start":"2026-07-02T10:14:10.647853Z","end":"2026-07-02T10:14:11.076038Z","steps":["trace[2084437740] 'process raft request' (duration: 62.076736ms)","trace[2084437740] 'compare' (duration: 365.618501ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:14:11.077079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:14:10.647834Z","time spent":"429.187739ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:14:11.077483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.935188ms","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-07-02T10:14:11.077537Z","caller":"traceutil/trace.go:171","msg":"trace[1221481767] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2585; }","duration":"338.026101ms","start":"2026-07-02T10:14:10.739496Z","end":"2026-07-02T10:14:11.077522Z","steps":["trace[1221481767] 'agreement among raft nodes before linearized reading' (duration: 336.662493ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:14:11.077581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:14:10.739478Z","time spent":"338.090582ms","remote":"127.0.0.1:33452","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-07-02T10:14:11.379245Z","caller":"traceutil/trace.go:171","msg":"trace[1287606026] linearizableReadLoop","detail":"{readStateIndex:2707; appliedIndex:2700; }","duration":"239.628018ms","start":"2026-07-02T10:14:11.139589Z","end":"2026-07-02T10:14:11.379217Z","steps":["trace[1287606026] 'read index received' (duration: 238.99166ms)","trace[1287606026] 'applied index is now lower than readState.Index' (duration: 635.098µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:14:11.379405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.546188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:14:11.379548Z","caller":"traceutil/trace.go:171","msg":"trace[2097746454] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:2593; }","duration":"296.660751ms","start":"2026-07-02T10:14:11.08281Z","end":"2026-07-02T10:14:11.379471Z","steps":["trace[2097746454] 'agreement among raft nodes before linearized reading' (duration: 296.517466ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:14:11.379974Z","caller":"traceutil/trace.go:171","msg":"trace[1858272125] transaction","detail":"{read_only:false; response_revision:2587; number_of_response:1; }","duration":"297.283318ms","start":"2026-07-02T10:14:11.082672Z","end":"2026-07-02T10:14:11.379955Z","steps":["trace[1858272125] 'process raft request' (duration: 296.015652ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:14:11.380191Z","caller":"traceutil/trace.go:171","msg":"trace[301204009] transaction","detail":"{read_only:false; response_revision:2588; number_of_response:1; }","duration":"297.493164ms","start":"2026-07-02T10:14:11.082679Z","end":"2026-07-02T10:14:11.380172Z","steps":["trace[301204009] 'process raft request' (duration: 296.160597ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:14:11.380387Z","caller":"traceutil/trace.go:171","msg":"trace[1007717576] transaction","detail":"{read_only:false; response_revision:2589; number_of_response:1; }","duration":"297.647609ms","start":"2026-07-02T10:14:11.082726Z","end":"2026-07-02T10:14:11.380373Z","steps":["trace[1007717576] 'process raft request' (duration: 296.168447ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:14:11.380575Z","caller":"traceutil/trace.go:171","msg":"trace[444407395] transaction","detail":"{read_only:false; response_revision:2590; number_of_response:1; }","duration":"297.820944ms","start":"2026-07-02T10:14:11.08274Z","end":"2026-07-02T10:14:11.380561Z","steps":["trace[444407395] 'process raft request' (duration: 296.289761ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:14:11.380761Z","caller":"traceutil/trace.go:171","msg":"trace[736338221] transaction","detail":"{read_only:false; response_revision:2591; number_of_response:1; }","duration":"297.982087ms","start":"2026-07-02T10:14:11.082765Z","end":"2026-07-02T10:14:11.380747Z","steps":["trace[736338221] 'process raft request' (duration: 296.30951ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:14:11.380953Z","caller":"traceutil/trace.go:171","msg":"trace[710262924] transaction","detail":"{read_only:false; response_revision:2592; number_of_response:1; }","duration":"297.550486ms","start":"2026-07-02T10:14:11.083388Z","end":"2026-07-02T10:14:11.380939Z","steps":["trace[710262924] 'process raft request' (duration: 295.734964ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:14:11.381144Z","caller":"traceutil/trace.go:171","msg":"trace[403279422] transaction","detail":"{read_only:false; response_revision:2593; number_of_response:1; }","duration":"297.71608ms","start":"2026-07-02T10:14:11.083415Z","end":"2026-07-02T10:14:11.381131Z","steps":["trace[403279422] 'process raft request' (duration: 295.754865ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:14:11.381439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.038607ms","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:524"} {"level":"info","ts":"2026-07-02T10:14:11.381509Z","caller":"traceutil/trace.go:171","msg":"trace[95572199] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2593; }","duration":"259.136689ms","start":"2026-07-02T10:14:11.12235Z","end":"2026-07-02T10:14:11.381487Z","steps":["trace[95572199] 'agreement among raft nodes before linearized reading' (duration: 258.920823ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:14:11.38181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.642282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"} {"level":"info","ts":"2026-07-02T10:14:11.381834Z","caller":"traceutil/trace.go:171","msg":"trace[1278627140] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2593; }","duration":"260.704313ms","start":"2026-07-02T10:14:11.121123Z","end":"2026-07-02T10:14:11.381828Z","steps":["trace[1278627140] 'agreement among raft nodes before linearized reading' (duration: 260.641211ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:14:11.70189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.544841ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T10:14:11.702083Z","caller":"traceutil/trace.go:171","msg":"trace[466989765] transaction","detail":"{read_only:false; response_revision:2594; number_of_response:1; }","duration":"312.739425ms","start":"2026-07-02T10:14:11.389318Z","end":"2026-07-02T10:14:11.702058Z","steps":["trace[466989765] 'process raft request' (duration: 81.949698ms)","trace[466989765] 'compare' (duration: 230.370175ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T10:14:11.702195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:14:11.389299Z","time spent":"312.838069ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":519,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T10:14:11.702172Z","caller":"traceutil/trace.go:171","msg":"trace[2108358168] transaction","detail":"{read_only:false; response_revision:2595; number_of_response:1; }","duration":"312.378246ms","start":"2026-07-02T10:14:11.389764Z","end":"2026-07-02T10:14:11.702142Z","steps":["trace[2108358168] 'process raft request' (duration: 312.221991ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:14:11.702309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:14:11.389736Z","time spent":"312.501739ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:14:12.357163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.510827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T10:14:12.357587Z","caller":"traceutil/trace.go:171","msg":"trace[321106157] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2595; }","duration":"425.996841ms","start":"2026-07-02T10:14:11.931557Z","end":"2026-07-02T10:14:12.357554Z","steps":["trace[321106157] 'range keys from in-memory index tree' (duration: 425.408504ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:14:12.357792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:14:11.931537Z","time spent":"426.237278ms","remote":"127.0.0.1:33218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-02T10:14:29.588879Z","caller":"traceutil/trace.go:171","msg":"trace[645323791] linearizableReadLoop","detail":"{readStateIndex:2794; appliedIndex:2793; }","duration":"340.029928ms","start":"2026-07-02T10:14:29.248814Z","end":"2026-07-02T10:14:29.588844Z","steps":["trace[645323791] 'read index received' (duration: 339.845503ms)","trace[645323791] 'applied index is now lower than readState.Index' (duration: 183.645µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T10:14:29.588958Z","caller":"traceutil/trace.go:171","msg":"trace[483605757] transaction","detail":"{read_only:false; response_revision:2676; number_of_response:1; }","duration":"423.312853ms","start":"2026-07-02T10:14:29.165624Z","end":"2026-07-02T10:14:29.588937Z","steps":["trace[483605757] 'process raft request' (duration: 423.111128ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:14:29.589067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.577899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-02T10:14:29.589113Z","caller":"traceutil/trace.go:171","msg":"trace[1392100476] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2676; }","duration":"103.663223ms","start":"2026-07-02T10:14:29.485439Z","end":"2026-07-02T10:14:29.589102Z","steps":["trace[1392100476] 'agreement among raft nodes before linearized reading' (duration: 103.54724ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:14:29.589142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:14:29.165584Z","time spent":"423.448058ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T10:14:29.589121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.302246ms","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-07-02T10:14:29.589194Z","caller":"traceutil/trace.go:171","msg":"trace[1784387874] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2676; }","duration":"340.413019ms","start":"2026-07-02T10:14:29.248769Z","end":"2026-07-02T10:14:29.589182Z","steps":["trace[1784387874] 'agreement among raft nodes before linearized reading' (duration: 340.188092ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T10:14:29.58926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T10:14:29.248748Z","time spent":"340.47011ms","remote":"127.0.0.1:33452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-02T10:16:00.072434Z","caller":"traceutil/trace.go:171","msg":"trace[1263949903] transaction","detail":"{read_only:false; response_revision:3091; number_of_response:1; }","duration":"138.535654ms","start":"2026-07-02T10:15:59.933881Z","end":"2026-07-02T10:16:00.072417Z","steps":["trace[1263949903] 'process raft request' (duration: 138.419521ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T10:16:47.317853Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1926} {"level":"info","ts":"2026-07-02T10:16:47.365225Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":1926,"took":"46.596407ms","hash":1180607478,"current-db-size-bytes":24625152,"current-db-size":"25 MB","current-db-size-in-use-bytes":6946816,"current-db-size-in-use":"6.9 MB"} {"level":"info","ts":"2026-07-02T10:16:47.365281Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1180607478,"revision":1926,"compact-revision":-1}