{"level":"warn","ts":"2026-06-26T03:35:53.923703Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-26T03:35:53.923837Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.14: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.14:2380","--initial-cluster=instance=https://199.19.213.14:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.14:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.14:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-26T03:35:53.923958Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-26T03:35:53.923977Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.14:2380"]} {"level":"info","ts":"2026-06-26T03:35:53.924012Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-26T03:35:53.925495Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.14:2379"]} {"level":"info","ts":"2026-06-26T03:35:53.925643Z","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.14:2380"],"listen-peer-urls":["https://199.19.213.14:2380"],"advertise-client-urls":["https://199.19.213.14:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.14:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.14:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-26T03:35:53.928541Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.48431ms"} {"level":"info","ts":"2026-06-26T03:35:53.93471Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"329f95029c2a91ed","cluster-id":"5fd85759a04d0f9f"} {"level":"info","ts":"2026-06-26T03:35:53.93482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed switched to configuration voters=()"} {"level":"info","ts":"2026-06-26T03:35:53.934854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became follower at term 0"} {"level":"info","ts":"2026-06-26T03:35:53.93491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 329f95029c2a91ed [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-26T03:35:53.93492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became follower at term 1"} {"level":"info","ts":"2026-06-26T03:35:53.934971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed switched to configuration voters=(3647798061635899885)"} {"level":"warn","ts":"2026-06-26T03:35:53.939998Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-26T03:35:53.942379Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-26T03:35:53.944315Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-26T03:35:53.948267Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"329f95029c2a91ed","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-26T03:35:53.948709Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"329f95029c2a91ed","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-26T03:35:53.948903Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-26T03:35:53.94897Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-26T03:35:53.948987Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-26T03:35:53.949289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed switched to configuration voters=(3647798061635899885)"} {"level":"info","ts":"2026-06-26T03:35:53.949762Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5fd85759a04d0f9f","local-member-id":"329f95029c2a91ed","added-peer-id":"329f95029c2a91ed","added-peer-peer-urls":["https://199.19.213.14:2380"]} {"level":"info","ts":"2026-06-26T03:35:53.95438Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-26T03:35:53.954672Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"329f95029c2a91ed","initial-advertise-peer-urls":["https://199.19.213.14:2380"],"listen-peer-urls":["https://199.19.213.14:2380"],"advertise-client-urls":["https://199.19.213.14:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.14:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-26T03:35:53.954731Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-26T03:35:53.954893Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.14:2380"} {"level":"info","ts":"2026-06-26T03:35:53.954983Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.14:2380"} {"level":"info","ts":"2026-06-26T03:35:54.535578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed is starting a new election at term 1"} {"level":"info","ts":"2026-06-26T03:35:54.535663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became pre-candidate at term 1"} {"level":"info","ts":"2026-06-26T03:35:54.535705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed received MsgPreVoteResp from 329f95029c2a91ed at term 1"} {"level":"info","ts":"2026-06-26T03:35:54.53573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became candidate at term 2"} {"level":"info","ts":"2026-06-26T03:35:54.535755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed received MsgVoteResp from 329f95029c2a91ed at term 2"} {"level":"info","ts":"2026-06-26T03:35:54.53578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became leader at term 2"} {"level":"info","ts":"2026-06-26T03:35:54.535795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 329f95029c2a91ed elected leader 329f95029c2a91ed at term 2"} {"level":"info","ts":"2026-06-26T03:35:54.536757Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T03:35:54.537695Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T03:35:54.537701Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"329f95029c2a91ed","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.14:2379]}","request-path":"/0/members/329f95029c2a91ed/attributes","cluster-id":"5fd85759a04d0f9f","publish-timeout":"7s"} {"level":"info","ts":"2026-06-26T03:35:54.53783Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5fd85759a04d0f9f","local-member-id":"329f95029c2a91ed","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T03:35:54.537834Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T03:35:54.537943Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T03:35:54.538Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T03:35:54.538117Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-26T03:35:54.538187Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-26T03:35:54.541298Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-26T03:35:54.542702Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.14:2379"} {"level":"info","ts":"2026-06-26T03:36:11.992941Z","caller":"traceutil/trace.go:171","msg":"trace[905349570] linearizableReadLoop","detail":"{readStateIndex:425; appliedIndex:424; }","duration":"135.731761ms","start":"2026-06-26T03:36:11.857176Z","end":"2026-06-26T03:36:11.992908Z","steps":["trace[905349570] 'read index received' (duration: 135.409392ms)","trace[905349570] 'applied index is now lower than readState.Index' (duration: 320.899µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:36:11.993028Z","caller":"traceutil/trace.go:171","msg":"trace[379963761] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"174.089251ms","start":"2026-06-26T03:36:11.818894Z","end":"2026-06-26T03:36:11.992983Z","steps":["trace[379963761] 'process raft request' (duration: 173.809032ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:11.993168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.958027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-26T03:36:11.993287Z","caller":"traceutil/trace.go:171","msg":"trace[108982214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:412; }","duration":"136.134653ms","start":"2026-06-26T03:36:11.857129Z","end":"2026-06-26T03:36:11.993264Z","steps":["trace[108982214] 'agreement among raft nodes before linearized reading' (duration: 135.922478ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:12.441305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.277952ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:36:12.44145Z","caller":"traceutil/trace.go:171","msg":"trace[279948810] linearizableReadLoop","detail":"{readStateIndex:426; appliedIndex:425; }","duration":"296.221227ms","start":"2026-06-26T03:36:12.145208Z","end":"2026-06-26T03:36:12.441429Z","steps":["trace[279948810] 'read index received' (duration: 74.617667ms)","trace[279948810] 'applied index is now lower than readState.Index' (duration: 221.602279ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:36:12.441599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.399522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-26T03:36:12.441659Z","caller":"traceutil/trace.go:171","msg":"trace[302744812] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:413; }","duration":"296.495934ms","start":"2026-06-26T03:36:12.145148Z","end":"2026-06-26T03:36:12.441644Z","steps":["trace[302744812] 'agreement among raft nodes before linearized reading' (duration: 296.397911ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:12.441689Z","caller":"traceutil/trace.go:171","msg":"trace[1109401738] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"444.493765ms","start":"2026-06-26T03:36:11.997114Z","end":"2026-06-26T03:36:12.441607Z","steps":["trace[1109401738] 'process raft request' (duration: 222.854075ms)","trace[1109401738] 'compare' (duration: 220.023324ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:36:12.442142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:11.997086Z","time spent":"444.808733ms","remote":"127.0.0.1:43550","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-06-26T03:36:14.597979Z","caller":"traceutil/trace.go:171","msg":"trace[1306467668] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"123.490395ms","start":"2026-06-26T03:36:14.474449Z","end":"2026-06-26T03:36:14.59794Z","steps":["trace[1306467668] 'process raft request' (duration: 123.271109ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:18.233636Z","caller":"traceutil/trace.go:171","msg":"trace[643833817] linearizableReadLoop","detail":"{readStateIndex:440; appliedIndex:439; }","duration":"209.882149ms","start":"2026-06-26T03:36:18.023726Z","end":"2026-06-26T03:36:18.233608Z","steps":["trace[643833817] 'read index received' (duration: 160.223022ms)","trace[643833817] 'applied index is now lower than readState.Index' (duration: 49.658027ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:36:18.2337Z","caller":"traceutil/trace.go:171","msg":"trace[425295735] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"330.578203ms","start":"2026-06-26T03:36:17.903083Z","end":"2026-06-26T03:36:18.233662Z","steps":["trace[425295735] 'process raft request' (duration: 280.923357ms)","trace[425295735] 'compare' (duration: 49.387368ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:36:18.233875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:17.903061Z","time spent":"330.748537ms","remote":"127.0.0.1:43294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:36:18.23388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.077785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-26T03:36:18.233935Z","caller":"traceutil/trace.go:171","msg":"trace[1502175574] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:425; }","duration":"210.257269ms","start":"2026-06-26T03:36:18.023665Z","end":"2026-06-26T03:36:18.233922Z","steps":["trace[1502175574] 'agreement among raft nodes before linearized reading' (duration: 210.028943ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:54.9976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.321401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:36:54.997711Z","caller":"traceutil/trace.go:171","msg":"trace[1736541426] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:511; }","duration":"108.503626ms","start":"2026-06-26T03:36:54.889182Z","end":"2026-06-26T03:36:54.997686Z","steps":["trace[1736541426] 'range keys from in-memory index tree' (duration: 108.241898ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:56.897247Z","caller":"traceutil/trace.go:171","msg":"trace[1001613012] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:535; }","duration":"107.382025ms","start":"2026-06-26T03:36:56.789841Z","end":"2026-06-26T03:36:56.897223Z","steps":["trace[1001613012] 'read index received' (duration: 107.358394ms)","trace[1001613012] 'applied index is now lower than readState.Index' (duration: 22.871µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:36:56.897368Z","caller":"traceutil/trace.go:171","msg":"trace[762688186] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"110.045479ms","start":"2026-06-26T03:36:56.787313Z","end":"2026-06-26T03:36:56.897359Z","steps":["trace[762688186] 'process raft request' (duration: 109.815273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:56.897506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.645912ms","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-06-26T03:36:56.897535Z","caller":"traceutil/trace.go:171","msg":"trace[1038674218] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:514; }","duration":"107.719534ms","start":"2026-06-26T03:36:56.789808Z","end":"2026-06-26T03:36:56.897527Z","steps":["trace[1038674218] 'agreement among raft nodes before linearized reading' (duration: 107.653052ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:59.107729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.197946ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:36:59.107849Z","caller":"traceutil/trace.go:171","msg":"trace[2000691959] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"156.70516ms","start":"2026-06-26T03:36:58.95112Z","end":"2026-06-26T03:36:59.107825Z","steps":["trace[2000691959] 'process raft request' (duration: 52.320778ms)","trace[2000691959] 'compare' (duration: 104.095113ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:37:22.828676Z","caller":"traceutil/trace.go:171","msg":"trace[1217248064] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"195.879223ms","start":"2026-06-26T03:37:22.632712Z","end":"2026-06-26T03:37:22.828591Z","steps":["trace[1217248064] 'process raft request' (duration: 195.566514ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:22.829725Z","caller":"traceutil/trace.go:171","msg":"trace[47880709] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"189.613968ms","start":"2026-06-26T03:37:22.640096Z","end":"2026-06-26T03:37:22.82971Z","steps":["trace[47880709] 'process raft request' (duration: 188.324962ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:22.82983Z","caller":"traceutil/trace.go:171","msg":"trace[1168447101] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"186.303156ms","start":"2026-06-26T03:37:22.643521Z","end":"2026-06-26T03:37:22.829824Z","steps":["trace[1168447101] 'process raft request' (duration: 186.132461ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:22.829844Z","caller":"traceutil/trace.go:171","msg":"trace[1638480434] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"174.118656ms","start":"2026-06-26T03:37:22.655704Z","end":"2026-06-26T03:37:22.829823Z","steps":["trace[1638480434] 'process raft request' (duration: 174.010713ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:22.829953Z","caller":"traceutil/trace.go:171","msg":"trace[569924902] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"171.134683ms","start":"2026-06-26T03:37:22.658793Z","end":"2026-06-26T03:37:22.829928Z","steps":["trace[569924902] 'process raft request' (duration: 170.966088ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:22.830112Z","caller":"traceutil/trace.go:171","msg":"trace[68683492] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"171.229775ms","start":"2026-06-26T03:37:22.658836Z","end":"2026-06-26T03:37:22.830065Z","steps":["trace[68683492] 'process raft request' (duration: 171.03465ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:22.830334Z","caller":"traceutil/trace.go:171","msg":"trace[1596576873] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"144.807999ms","start":"2026-06-26T03:37:22.685515Z","end":"2026-06-26T03:37:22.830323Z","steps":["trace[1596576873] 'process raft request' (duration: 144.739647ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:22.830395Z","caller":"traceutil/trace.go:171","msg":"trace[422533748] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"153.000226ms","start":"2026-06-26T03:37:22.677389Z","end":"2026-06-26T03:37:22.83039Z","steps":["trace[422533748] 'process raft request' (duration: 152.799261ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:22.83039Z","caller":"traceutil/trace.go:171","msg":"trace[485697655] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"166.76943ms","start":"2026-06-26T03:37:22.663607Z","end":"2026-06-26T03:37:22.830376Z","steps":["trace[485697655] 'process raft request' (duration: 166.545984ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:22.83044Z","caller":"traceutil/trace.go:171","msg":"trace[376354342] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"171.543804ms","start":"2026-06-26T03:37:22.658892Z","end":"2026-06-26T03:37:22.830436Z","steps":["trace[376354342] 'process raft request' (duration: 171.016409ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:22.832028Z","caller":"traceutil/trace.go:171","msg":"trace[1491389976] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"128.032209ms","start":"2026-06-26T03:37:22.703982Z","end":"2026-06-26T03:37:22.832014Z","steps":["trace[1491389976] 'process raft request' (duration: 127.816813ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:23.393709Z","caller":"traceutil/trace.go:171","msg":"trace[654187789] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"289.864164ms","start":"2026-06-26T03:37:23.10382Z","end":"2026-06-26T03:37:23.393684Z","steps":["trace[654187789] 'process raft request' (duration: 221.740504ms)","trace[654187789] 'compare' (duration: 67.984566ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:37:23.394069Z","caller":"traceutil/trace.go:171","msg":"trace[2014285442] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"271.031289ms","start":"2026-06-26T03:37:23.122999Z","end":"2026-06-26T03:37:23.39403Z","steps":["trace[2014285442] 'process raft request' (duration: 270.793802ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:23.394236Z","caller":"traceutil/trace.go:171","msg":"trace[913489197] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"254.944549ms","start":"2026-06-26T03:37:23.139285Z","end":"2026-06-26T03:37:23.394229Z","steps":["trace[913489197] 'process raft request' (duration: 254.684022ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:23.394259Z","caller":"traceutil/trace.go:171","msg":"trace[1628771591] linearizableReadLoop","detail":"{readStateIndex:724; appliedIndex:721; }","duration":"174.304551ms","start":"2026-06-26T03:37:23.219909Z","end":"2026-06-26T03:37:23.394213Z","steps":["trace[1628771591] 'read index received' (duration: 105.741619ms)","trace[1628771591] 'applied index is now lower than readState.Index' (duration: 68.561102ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:37:23.394463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.549697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-26T03:37:23.394492Z","caller":"traceutil/trace.go:171","msg":"trace[1499103684] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:688; }","duration":"174.615239ms","start":"2026-06-26T03:37:23.219868Z","end":"2026-06-26T03:37:23.394483Z","steps":["trace[1499103684] 'agreement among raft nodes before linearized reading' (duration: 174.483256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:24.260197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.34158ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:37:24.260371Z","caller":"traceutil/trace.go:171","msg":"trace[547646953] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"217.723913ms","start":"2026-06-26T03:37:24.042594Z","end":"2026-06-26T03:37:24.260318Z","steps":["trace[547646953] 'process raft request' (duration: 40.611011ms)","trace[547646953] 'compare' (duration: 175.869437ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:37:24.261341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.952529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570096"} {"level":"info","ts":"2026-06-26T03:37:24.261439Z","caller":"traceutil/trace.go:171","msg":"trace[2092370892] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:712; }","duration":"125.093122ms","start":"2026-06-26T03:37:24.13632Z","end":"2026-06-26T03:37:24.261413Z","steps":["trace[2092370892] 'agreement among raft nodes before linearized reading' (duration: 124.316011ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:24.260294Z","caller":"traceutil/trace.go:171","msg":"trace[610932272] linearizableReadLoop","detail":"{readStateIndex:748; appliedIndex:747; }","duration":"123.927611ms","start":"2026-06-26T03:37:24.136351Z","end":"2026-06-26T03:37:24.260279Z","steps":["trace[610932272] 'read index received' (duration: 43.291µs)","trace[610932272] 'applied index is now lower than readState.Index' (duration: 123.88306ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:37:24.334484Z","caller":"traceutil/trace.go:171","msg":"trace[1981678113] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"171.226037ms","start":"2026-06-26T03:37:24.163244Z","end":"2026-06-26T03:37:24.33447Z","steps":["trace[1981678113] 'process raft request' (duration: 170.644801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:25.156248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.828315ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:37:25.156346Z","caller":"traceutil/trace.go:171","msg":"trace[487693185] linearizableReadLoop","detail":"{readStateIndex:750; appliedIndex:749; }","duration":"807.907936ms","start":"2026-06-26T03:37:24.348423Z","end":"2026-06-26T03:37:25.156331Z","steps":["trace[487693185] 'read index received' (duration: 69.816304ms)","trace[487693185] 'applied index is now lower than readState.Index' (duration: 738.090592ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:37:25.156767Z","caller":"traceutil/trace.go:171","msg":"trace[2037501002] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"812.72566ms","start":"2026-06-26T03:37:24.344009Z","end":"2026-06-26T03:37:25.156735Z","steps":["trace[2037501002] 'process raft request' (duration: 74.3313ms)","trace[2037501002] 'compare' (duration: 737.610778ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:37:25.156862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"808.42873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:10870"} {"level":"info","ts":"2026-06-26T03:37:25.156916Z","caller":"traceutil/trace.go:171","msg":"trace[2145047264] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:714; }","duration":"808.503222ms","start":"2026-06-26T03:37:24.3484Z","end":"2026-06-26T03:37:25.156903Z","steps":["trace[2145047264] 'agreement among raft nodes before linearized reading' (duration: 808.343078ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:25.15695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:24.348385Z","time spent":"808.556233ms","remote":"127.0.0.1:43306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":10892,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-06-26T03:37:25.156954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:24.343993Z","time spent":"812.854793ms","remote":"127.0.0.1:43306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:37:25.194626Z","caller":"traceutil/trace.go:171","msg":"trace[118786248] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"812.00664ms","start":"2026-06-26T03:37:24.382603Z","end":"2026-06-26T03:37:25.194609Z","steps":["trace[118786248] 'process raft request' (duration: 811.687181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:25.194732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:24.382584Z","time spent":"812.091462ms","remote":"127.0.0.1:43306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:37:25.195046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.979351ms","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-06-26T03:37:25.195072Z","caller":"traceutil/trace.go:171","msg":"trace[243261313] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:715; }","duration":"120.004571ms","start":"2026-06-26T03:37:25.075058Z","end":"2026-06-26T03:37:25.195063Z","steps":["trace[243261313] 'agreement among raft nodes before linearized reading' (duration: 119.913619ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:25.195187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.620125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-26T03:37:25.195203Z","caller":"traceutil/trace.go:171","msg":"trace[656492426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:715; }","duration":"275.663446ms","start":"2026-06-26T03:37:24.919534Z","end":"2026-06-26T03:37:25.195198Z","steps":["trace[656492426] 'agreement among raft nodes before linearized reading' (duration: 275.614164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:25.195277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.829105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:37:25.195291Z","caller":"traceutil/trace.go:171","msg":"trace[897923972] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:715; }","duration":"305.870367ms","start":"2026-06-26T03:37:24.889416Z","end":"2026-06-26T03:37:25.195287Z","steps":["trace[897923972] 'agreement among raft nodes before linearized reading' (duration: 305.847366ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:25.195305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:24.889401Z","time spent":"305.900178ms","remote":"127.0.0.1:43274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T03:37:25.19542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.731747ms","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-06-26T03:37:25.19544Z","caller":"traceutil/trace.go:171","msg":"trace[1682481848] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:715; }","duration":"503.807458ms","start":"2026-06-26T03:37:24.691627Z","end":"2026-06-26T03:37:25.195435Z","steps":["trace[1682481848] 'agreement among raft nodes before linearized reading' (duration: 503.771317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:25.195455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:24.691608Z","time spent":"503.843798ms","remote":"127.0.0.1:43550","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-06-26T03:37:29.365137Z","caller":"traceutil/trace.go:171","msg":"trace[529423446] linearizableReadLoop","detail":"{readStateIndex:777; appliedIndex:776; }","duration":"146.487079ms","start":"2026-06-26T03:37:29.218629Z","end":"2026-06-26T03:37:29.365116Z","steps":["trace[529423446] 'read index received' (duration: 145.78906ms)","trace[529423446] 'applied index is now lower than readState.Index' (duration: 696.879µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:37:29.365263Z","caller":"traceutil/trace.go:171","msg":"trace[601374647] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"448.043135ms","start":"2026-06-26T03:37:28.917181Z","end":"2026-06-26T03:37:29.365224Z","steps":["trace[601374647] 'process raft request' (duration: 447.50253ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:29.365353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.702795ms","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-06-26T03:37:29.365387Z","caller":"traceutil/trace.go:171","msg":"trace[393960183] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:740; }","duration":"146.787438ms","start":"2026-06-26T03:37:29.21859Z","end":"2026-06-26T03:37:29.365377Z","steps":["trace[393960183] 'agreement among raft nodes before linearized reading' (duration: 146.636873ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:29.365399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.931893ms","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-06-26T03:37:29.365435Z","caller":"traceutil/trace.go:171","msg":"trace[1565170675] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:740; }","duration":"146.011024ms","start":"2026-06-26T03:37:29.219412Z","end":"2026-06-26T03:37:29.365423Z","steps":["trace[1565170675] 'agreement among raft nodes before linearized reading' (duration: 145.917872ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:29.365424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:28.917148Z","time spent":"448.187189ms","remote":"127.0.0.1:43346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036221,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:37:29.365602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.017226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-26T03:37:29.36569Z","caller":"traceutil/trace.go:171","msg":"trace[1373168911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:740; }","duration":"146.15515ms","start":"2026-06-26T03:37:29.219511Z","end":"2026-06-26T03:37:29.365666Z","steps":["trace[1373168911] 'agreement among raft nodes before linearized reading' (duration: 145.889282ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:29.517992Z","caller":"traceutil/trace.go:171","msg":"trace[1311838855] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"147.9516ms","start":"2026-06-26T03:37:29.369466Z","end":"2026-06-26T03:37:29.517418Z","steps":["trace[1311838855] 'process raft request' (duration: 147.776585ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:29.526009Z","caller":"traceutil/trace.go:171","msg":"trace[626115474] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"156.118716ms","start":"2026-06-26T03:37:29.369866Z","end":"2026-06-26T03:37:29.525985Z","steps":["trace[626115474] 'process raft request' (duration: 155.956612ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:29.52645Z","caller":"traceutil/trace.go:171","msg":"trace[2020916597] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"156.502138ms","start":"2026-06-26T03:37:29.369937Z","end":"2026-06-26T03:37:29.526439Z","steps":["trace[2020916597] 'process raft request' (duration: 156.008605ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:29.526615Z","caller":"traceutil/trace.go:171","msg":"trace[453224506] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"105.287323ms","start":"2026-06-26T03:37:29.421304Z","end":"2026-06-26T03:37:29.526591Z","steps":["trace[453224506] 'process raft request' (duration: 104.890681ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:30.285369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.706294ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:37:30.285508Z","caller":"traceutil/trace.go:171","msg":"trace[1155250272] linearizableReadLoop","detail":"{readStateIndex:783; appliedIndex:782; }","duration":"399.141872ms","start":"2026-06-26T03:37:29.88634Z","end":"2026-06-26T03:37:30.285482Z","steps":["trace[1155250272] 'read index received' (duration: 25.611µs)","trace[1155250272] 'applied index is now lower than readState.Index' (duration: 399.11468ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:37:30.285635Z","caller":"traceutil/trace.go:171","msg":"trace[184523042] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"744.424347ms","start":"2026-06-26T03:37:29.54119Z","end":"2026-06-26T03:37:30.285614Z","steps":["trace[184523042] 'process raft request' (duration: 97.319291ms)","trace[184523042] 'compare' (duration: 646.522189ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:37:30.285721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:29.541183Z","time spent":"744.494358ms","remote":"127.0.0.1:43456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:37:30.285874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.501532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:37:30.285999Z","caller":"traceutil/trace.go:171","msg":"trace[1864652153] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:746; }","duration":"399.665707ms","start":"2026-06-26T03:37:29.88631Z","end":"2026-06-26T03:37:30.285976Z","steps":["trace[1864652153] 'agreement among raft nodes before linearized reading' (duration: 399.40538ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:30.286138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:29.886296Z","time spent":"399.82684ms","remote":"127.0.0.1:43274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T03:37:30.786439Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515235535911474563,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T03:37:30.897286Z","caller":"traceutil/trace.go:171","msg":"trace[394173718] linearizableReadLoop","detail":"{readStateIndex:784; appliedIndex:783; }","duration":"611.697834ms","start":"2026-06-26T03:37:30.285564Z","end":"2026-06-26T03:37:30.897262Z","steps":["trace[394173718] 'read index received' (duration: 611.599841ms)","trace[394173718] 'applied index is now lower than readState.Index' (duration: 96.493µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:37:30.897318Z","caller":"traceutil/trace.go:171","msg":"trace[1823923218] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"912.476746ms","start":"2026-06-26T03:37:29.984822Z","end":"2026-06-26T03:37:30.897298Z","steps":["trace[1823923218] 'process raft request' (duration: 911.769786ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:30.898223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:29.9848Z","time spent":"912.588879ms","remote":"127.0.0.1:43346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:37:30.898313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.667206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T03:37:30.898301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"866.23908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:37:30.898424Z","caller":"traceutil/trace.go:171","msg":"trace[322342566] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:747; }","duration":"610.786908ms","start":"2026-06-26T03:37:30.287591Z","end":"2026-06-26T03:37:30.898378Z","steps":["trace[322342566] 'agreement among raft nodes before linearized reading' (duration: 609.834862ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:30.898487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:30.287574Z","time spent":"610.895371ms","remote":"127.0.0.1:43276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T03:37:30.898422Z","caller":"traceutil/trace.go:171","msg":"trace[1757735779] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:747; }","duration":"867.242008ms","start":"2026-06-26T03:37:30.031155Z","end":"2026-06-26T03:37:30.898397Z","steps":["trace[1757735779] 'agreement among raft nodes before linearized reading' (duration: 866.25527ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:30.898611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:30.031131Z","time spent":"867.422002ms","remote":"127.0.0.1:43416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"info","ts":"2026-06-26T03:37:33.899459Z","caller":"traceutil/trace.go:171","msg":"trace[814431377] linearizableReadLoop","detail":"{readStateIndex:821; appliedIndex:820; }","duration":"191.705828ms","start":"2026-06-26T03:37:33.707727Z","end":"2026-06-26T03:37:33.899433Z","steps":["trace[814431377] 'read index received' (duration: 191.487252ms)","trace[814431377] 'applied index is now lower than readState.Index' (duration: 217.346µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:37:33.899511Z","caller":"traceutil/trace.go:171","msg":"trace[1472178166] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"214.915294ms","start":"2026-06-26T03:37:33.684568Z","end":"2026-06-26T03:37:33.899483Z","steps":["trace[1472178166] 'process raft request' (duration: 214.660577ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:33.899915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.13479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T03:37:33.900029Z","caller":"traceutil/trace.go:171","msg":"trace[1874829125] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:783; }","duration":"192.315466ms","start":"2026-06-26T03:37:33.707687Z","end":"2026-06-26T03:37:33.900002Z","steps":["trace[1874829125] 'agreement among raft nodes before linearized reading' (duration: 191.878233ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:35.813141Z","caller":"traceutil/trace.go:171","msg":"trace[1988115765] linearizableReadLoop","detail":"{readStateIndex:862; appliedIndex:861; }","duration":"107.76847ms","start":"2026-06-26T03:37:35.705349Z","end":"2026-06-26T03:37:35.813118Z","steps":["trace[1988115765] 'read index received' (duration: 107.542404ms)","trace[1988115765] 'applied index is now lower than readState.Index' (duration: 224.886µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:37:35.813226Z","caller":"traceutil/trace.go:171","msg":"trace[686794345] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"110.065724ms","start":"2026-06-26T03:37:35.703128Z","end":"2026-06-26T03:37:35.813194Z","steps":["trace[686794345] 'process raft request' (duration: 109.847618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:35.813364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.976916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:37:35.813452Z","caller":"traceutil/trace.go:171","msg":"trace[2077648476] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:824; }","duration":"108.10571ms","start":"2026-06-26T03:37:35.705324Z","end":"2026-06-26T03:37:35.813429Z","steps":["trace[2077648476] 'agreement among raft nodes before linearized reading' (duration: 107.955936ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:46.115883Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515235535911474947,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T03:37:46.326435Z","caller":"traceutil/trace.go:171","msg":"trace[239246840] linearizableReadLoop","detail":"{readStateIndex:950; appliedIndex:949; }","duration":"710.636105ms","start":"2026-06-26T03:37:45.615781Z","end":"2026-06-26T03:37:46.326417Z","steps":["trace[239246840] 'read index received' (duration: 710.489671ms)","trace[239246840] 'applied index is now lower than readState.Index' (duration: 145.933µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:37:46.326532Z","caller":"traceutil/trace.go:171","msg":"trace[1940231213] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"715.768138ms","start":"2026-06-26T03:37:45.61074Z","end":"2026-06-26T03:37:46.326508Z","steps":["trace[1940231213] 'process raft request' (duration: 715.579924ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:46.326603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.80728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-26T03:37:46.326622Z","caller":"traceutil/trace.go:171","msg":"trace[388681442] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:909; }","duration":"710.867891ms","start":"2026-06-26T03:37:45.615748Z","end":"2026-06-26T03:37:46.326616Z","steps":["trace[388681442] 'agreement among raft nodes before linearized reading' (duration: 710.761728ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:46.326644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:45.615731Z","time spent":"710.909794ms","remote":"127.0.0.1:43550","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-06-26T03:37:46.326653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:45.610718Z","time spent":"715.873531ms","remote":"127.0.0.1:43456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:37:46.326742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.167209ms","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-06-26T03:37:46.326816Z","caller":"traceutil/trace.go:171","msg":"trace[1997210368] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:909; }","duration":"707.307434ms","start":"2026-06-26T03:37:45.61949Z","end":"2026-06-26T03:37:46.326798Z","steps":["trace[1997210368] 'agreement among raft nodes before linearized reading' (duration: 707.081047ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:46.326808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.736837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T03:37:46.326858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:45.619459Z","time spent":"707.391746ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T03:37:46.326929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.322984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T03:37:46.326948Z","caller":"traceutil/trace.go:171","msg":"trace[1364110564] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:909; }","duration":"322.376475ms","start":"2026-06-26T03:37:46.004565Z","end":"2026-06-26T03:37:46.326941Z","steps":["trace[1364110564] 'agreement among raft nodes before linearized reading' (duration: 322.323744ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:46.326956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.539313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T03:37:46.326973Z","caller":"traceutil/trace.go:171","msg":"trace[1339988307] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:909; }","duration":"288.607586ms","start":"2026-06-26T03:37:46.038361Z","end":"2026-06-26T03:37:46.326969Z","steps":["trace[1339988307] 'agreement among raft nodes before linearized reading' (duration: 288.524823ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:46.326974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:46.004539Z","time spent":"322.420087ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-26T03:37:46.326868Z","caller":"traceutil/trace.go:171","msg":"trace[648159092] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:909; }","duration":"437.846141ms","start":"2026-06-26T03:37:45.889007Z","end":"2026-06-26T03:37:46.326853Z","steps":["trace[648159092] 'agreement among raft nodes before linearized reading' (duration: 437.749658ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:46.32702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:45.888987Z","time spent":"438.029765ms","remote":"127.0.0.1:43274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T03:37:46.32703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.266368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-26T03:37:46.327065Z","caller":"traceutil/trace.go:171","msg":"trace[396344155] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:909; }","duration":"704.34537ms","start":"2026-06-26T03:37:45.622706Z","end":"2026-06-26T03:37:46.327052Z","steps":["trace[396344155] 'agreement among raft nodes before linearized reading' (duration: 704.245597ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:46.327093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:45.622687Z","time spent":"704.399092ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T03:37:46.327205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.095138ms","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-06-26T03:37:46.327224Z","caller":"traceutil/trace.go:171","msg":"trace[422292473] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:909; }","duration":"702.134629ms","start":"2026-06-26T03:37:45.625083Z","end":"2026-06-26T03:37:46.327218Z","steps":["trace[422292473] 'agreement among raft nodes before linearized reading' (duration: 702.056737ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:46.327245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:45.625071Z","time spent":"702.16473ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-26T03:37:46.52475Z","caller":"traceutil/trace.go:171","msg":"trace[1774728820] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"193.105766ms","start":"2026-06-26T03:37:46.331615Z","end":"2026-06-26T03:37:46.524721Z","steps":["trace[1774728820] 'process raft request' (duration: 190.200245ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:46.525209Z","caller":"traceutil/trace.go:171","msg":"trace[1349675858] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"193.314712ms","start":"2026-06-26T03:37:46.331832Z","end":"2026-06-26T03:37:46.525146Z","steps":["trace[1349675858] 'process raft request' (duration: 192.785797ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:46.526308Z","caller":"traceutil/trace.go:171","msg":"trace[1759652587] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"194.292339ms","start":"2026-06-26T03:37:46.332002Z","end":"2026-06-26T03:37:46.526294Z","steps":["trace[1759652587] 'process raft request' (duration: 192.783927ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:46.526484Z","caller":"traceutil/trace.go:171","msg":"trace[1596541828] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"194.401962ms","start":"2026-06-26T03:37:46.33205Z","end":"2026-06-26T03:37:46.526452Z","steps":["trace[1596541828] 'process raft request' (duration: 194.155506ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:46.526716Z","caller":"traceutil/trace.go:171","msg":"trace[1959877468] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"194.151276ms","start":"2026-06-26T03:37:46.332549Z","end":"2026-06-26T03:37:46.526701Z","steps":["trace[1959877468] 'process raft request' (duration: 193.794726ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:53.058398Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515235535911475067,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T03:37:53.062763Z","caller":"traceutil/trace.go:171","msg":"trace[414998357] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"510.974068ms","start":"2026-06-26T03:37:52.551775Z","end":"2026-06-26T03:37:53.062749Z","steps":["trace[414998357] 'process raft request' (duration: 510.880195ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:53.063068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:52.551724Z","time spent":"511.293226ms","remote":"127.0.0.1:43550","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-06-26T03:37:53.067428Z","caller":"traceutil/trace.go:171","msg":"trace[1761671769] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"515.333778ms","start":"2026-06-26T03:37:52.552084Z","end":"2026-06-26T03:37:53.067418Z","steps":["trace[1761671769] 'process raft request' (duration: 515.235325ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:53.0675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:52.552053Z","time spent":"515.40832ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:37:53.067596Z","caller":"traceutil/trace.go:171","msg":"trace[1174873168] linearizableReadLoop","detail":"{readStateIndex:1018; appliedIndex:1016; }","duration":"515.3609ms","start":"2026-06-26T03:37:52.552218Z","end":"2026-06-26T03:37:53.067579Z","steps":["trace[1174873168] 'read index received' (duration: 510.908756ms)","trace[1174873168] 'applied index is now lower than readState.Index' (duration: 4.451254ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:37:53.067754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.552764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-26T03:37:53.067785Z","caller":"traceutil/trace.go:171","msg":"trace[534313294] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:976; }","duration":"515.614236ms","start":"2026-06-26T03:37:52.552164Z","end":"2026-06-26T03:37:53.067778Z","steps":["trace[534313294] 'agreement among raft nodes before linearized reading' (duration: 515.524354ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:53.0678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:52.552154Z","time spent":"515.642607ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-26T03:37:53.06787Z","caller":"traceutil/trace.go:171","msg":"trace[868490432] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"329.171815ms","start":"2026-06-26T03:37:52.738693Z","end":"2026-06-26T03:37:53.067865Z","steps":["trace[868490432] 'process raft request' (duration: 328.700312ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:53.067865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.183595ms","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-06-26T03:37:53.0679Z","caller":"traceutil/trace.go:171","msg":"trace[87417925] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:976; }","duration":"515.265986ms","start":"2026-06-26T03:37:52.552623Z","end":"2026-06-26T03:37:53.067889Z","steps":["trace[87417925] 'agreement among raft nodes before linearized reading' (duration: 515.174464ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:53.067906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:52.738668Z","time spent":"329.218027ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:37:53.067937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:52.552605Z","time spent":"515.321979ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T03:37:53.068373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.393471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T03:37:53.068455Z","caller":"traceutil/trace.go:171","msg":"trace[1303616119] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:976; }","duration":"506.515663ms","start":"2026-06-26T03:37:52.561917Z","end":"2026-06-26T03:37:53.068433Z","steps":["trace[1303616119] 'agreement among raft nodes before linearized reading' (duration: 506.254186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:53.068496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:52.561905Z","time spent":"506.583555ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-26T03:38:21.584354Z","caller":"traceutil/trace.go:171","msg":"trace[1169124268] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"361.037462ms","start":"2026-06-26T03:38:21.223274Z","end":"2026-06-26T03:38:21.584312Z","steps":["trace[1169124268] 'process raft request' (duration: 360.839658ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:38:21.584552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:38:21.223265Z","time spent":"361.201817ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:38:21.584682Z","caller":"traceutil/trace.go:171","msg":"trace[784243873] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"361.007273ms","start":"2026-06-26T03:38:21.223648Z","end":"2026-06-26T03:38:21.584655Z","steps":["trace[784243873] 'process raft request' (duration: 360.960421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:38:21.584806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:38:21.223641Z","time spent":"361.100174ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:38:21.584909Z","caller":"traceutil/trace.go:171","msg":"trace[555070690] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"361.423263ms","start":"2026-06-26T03:38:21.223479Z","end":"2026-06-26T03:38:21.584902Z","steps":["trace[555070690] 'process raft request' (duration: 361.019122ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:38:21.584906Z","caller":"traceutil/trace.go:171","msg":"trace[1233091848] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"361.457774ms","start":"2026-06-26T03:38:21.223436Z","end":"2026-06-26T03:38:21.584893Z","steps":["trace[1233091848] 'process raft request' (duration: 360.833537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:38:21.584947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:38:21.223459Z","time spent":"361.464754ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:38:21.584969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:38:21.223413Z","time spent":"361.522696ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:38:22.644973Z","caller":"traceutil/trace.go:171","msg":"trace[1834335452] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"142.957179ms","start":"2026-06-26T03:38:22.501993Z","end":"2026-06-26T03:38:22.64495Z","steps":["trace[1834335452] 'process raft request' (duration: 142.811316ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:38:29.730496Z","caller":"traceutil/trace.go:171","msg":"trace[806572698] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"376.603694ms","start":"2026-06-26T03:38:29.353869Z","end":"2026-06-26T03:38:29.730473Z","steps":["trace[806572698] 'process raft request' (duration: 376.47082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:38:29.73064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:38:29.353848Z","time spent":"376.718807ms","remote":"127.0.0.1:43550","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-06-26T03:38:29.733921Z","caller":"traceutil/trace.go:171","msg":"trace[1368260492] linearizableReadLoop","detail":"{readStateIndex:1199; appliedIndex:1197; }","duration":"119.255317ms","start":"2026-06-26T03:38:29.614635Z","end":"2026-06-26T03:38:29.73389Z","steps":["trace[1368260492] 'read index received' (duration: 116.382227ms)","trace[1368260492] 'applied index is now lower than readState.Index' (duration: 2.87182ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:38:29.734069Z","caller":"traceutil/trace.go:171","msg":"trace[821450321] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"253.426609ms","start":"2026-06-26T03:38:29.480627Z","end":"2026-06-26T03:38:29.734053Z","steps":["trace[821450321] 'process raft request' (duration: 253.209013ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:38:29.73394Z","caller":"traceutil/trace.go:171","msg":"trace[284927507] transaction","detail":"{read_only:false; response_revision:1148; number_of_response:1; }","duration":"377.942551ms","start":"2026-06-26T03:38:29.355969Z","end":"2026-06-26T03:38:29.733912Z","steps":["trace[284927507] 'process raft request' (duration: 377.715715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:38:29.734299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:38:29.355952Z","time spent":"378.28214ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:38:29.734475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.066126ms","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-06-26T03:38:29.734523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.881114ms","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-06-26T03:38:29.734552Z","caller":"traceutil/trace.go:171","msg":"trace[877269892] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1149; }","duration":"119.951256ms","start":"2026-06-26T03:38:29.614592Z","end":"2026-06-26T03:38:29.734543Z","steps":["trace[877269892] 'agreement among raft nodes before linearized reading' (duration: 119.840403ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:38:29.734519Z","caller":"traceutil/trace.go:171","msg":"trace[782024445] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1149; }","duration":"112.1674ms","start":"2026-06-26T03:38:29.622339Z","end":"2026-06-26T03:38:29.734507Z","steps":["trace[782024445] 'agreement among raft nodes before linearized reading' (duration: 112.001335ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:38:29.734698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.558483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T03:38:29.734715Z","caller":"traceutil/trace.go:171","msg":"trace[1561003132] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1149; }","duration":"111.601724ms","start":"2026-06-26T03:38:29.623108Z","end":"2026-06-26T03:38:29.73471Z","steps":["trace[1561003132] 'agreement among raft nodes before linearized reading' (duration: 111.552962ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:38:29.734879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.170629ms","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-06-26T03:38:29.734897Z","caller":"traceutil/trace.go:171","msg":"trace[1304262719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1149; }","duration":"112.235932ms","start":"2026-06-26T03:38:29.622655Z","end":"2026-06-26T03:38:29.734891Z","steps":["trace[1304262719] 'agreement among raft nodes before linearized reading' (duration: 112.18038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:38:48.216999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:38:47.671359Z","time spent":"545.634525ms","remote":"127.0.0.1:43294","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-26T03:38:49.357976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096902277s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:38:49.358159Z","caller":"traceutil/trace.go:171","msg":"trace[2128642469] linearizableReadLoop","detail":"{readStateIndex:1260; appliedIndex:1258; }","duration":"1.515302223s","start":"2026-06-26T03:38:47.842837Z","end":"2026-06-26T03:38:49.358139Z","steps":["trace[2128642469] 'read index received' (duration: 374.021232ms)","trace[2128642469] 'applied index is now lower than readState.Index' (duration: 1.141279021s)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:38:49.358539Z","caller":"traceutil/trace.go:171","msg":"trace[428409388] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"1.560868312s","start":"2026-06-26T03:38:47.79762Z","end":"2026-06-26T03:38:49.358488Z","steps":["trace[428409388] 'process raft request' (duration: 463.368668ms)","trace[428409388] 'compare' (duration: 1.096077734s)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:38:49.358543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.515693025s","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-06-26T03:38:49.358854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:38:47.797601Z","time spent":"1.561013346s","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:38:49.358881Z","caller":"traceutil/trace.go:171","msg":"trace[1429971237] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1206; }","duration":"1.516096707s","start":"2026-06-26T03:38:47.842768Z","end":"2026-06-26T03:38:49.358865Z","steps":["trace[1429971237] 'agreement among raft nodes before linearized reading' (duration: 1.515628814s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:38:49.359074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:38:47.842743Z","time spent":"1.516295301s","remote":"127.0.0.1:43550","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-06-26T03:38:49.468719Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.207705069s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T03:38:49.541157Z","caller":"traceutil/trace.go:171","msg":"trace[1909535016] linearizableReadLoop","detail":"{readStateIndex:1261; appliedIndex:1260; }","duration":"182.914336ms","start":"2026-06-26T03:38:49.358211Z","end":"2026-06-26T03:38:49.541126Z","steps":["trace[1909535016] 'read index received' (duration: 111.059528ms)","trace[1909535016] 'applied index is now lower than readState.Index' (duration: 71.853688ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:38:49.541353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.680341215s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T03:38:49.541425Z","caller":"traceutil/trace.go:171","msg":"trace[1598064115] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1207; }","duration":"1.680471618s","start":"2026-06-26T03:38:47.860934Z","end":"2026-06-26T03:38:49.541406Z","steps":["trace[1598064115] 'agreement among raft nodes before linearized reading' (duration: 1.680227061s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:38:49.54149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:38:47.860916Z","time spent":"1.6805593s","remote":"127.0.0.1:43550","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-06-26T03:38:49.541534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.690304502s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-26T03:38:49.541588Z","caller":"traceutil/trace.go:171","msg":"trace[981852748] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1207; }","duration":"1.690395674s","start":"2026-06-26T03:38:47.851179Z","end":"2026-06-26T03:38:49.541575Z","steps":["trace[981852748] 'agreement among raft nodes before linearized reading' (duration: 1.690279321s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:38:49.541633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:38:47.851158Z","time spent":"1.690464217s","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T03:38:49.541636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.681194788s","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-06-26T03:38:49.541703Z","caller":"traceutil/trace.go:171","msg":"trace[1945106993] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1207; }","duration":"1.681303651s","start":"2026-06-26T03:38:47.860381Z","end":"2026-06-26T03:38:49.541685Z","steps":["trace[1945106993] 'agreement among raft nodes before linearized reading' (duration: 1.681086515s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:38:49.541744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:38:47.860367Z","time spent":"1.681369743s","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T03:38:49.541776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.413703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T03:38:49.541431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.695177358s","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-06-26T03:38:49.541834Z","caller":"traceutil/trace.go:171","msg":"trace[1597819334] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1207; }","duration":"653.495865ms","start":"2026-06-26T03:38:48.888317Z","end":"2026-06-26T03:38:49.541813Z","steps":["trace[1597819334] 'agreement among raft nodes before linearized reading' (duration: 653.411203ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:38:49.541843Z","caller":"traceutil/trace.go:171","msg":"trace[122819379] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1207; }","duration":"1.695611429s","start":"2026-06-26T03:38:47.846217Z","end":"2026-06-26T03:38:49.541828Z","steps":["trace[122819379] 'agreement among raft nodes before linearized reading' (duration: 1.695027273s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:38:49.541882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:38:48.888298Z","time spent":"653.572758ms","remote":"127.0.0.1:43274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T03:38:49.541969Z","caller":"traceutil/trace.go:171","msg":"trace[1219572] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"1.323521321s","start":"2026-06-26T03:38:48.218429Z","end":"2026-06-26T03:38:49.541951Z","steps":["trace[1219572] 'process raft request' (duration: 1.250675084s)","trace[1219572] 'compare' (duration: 71.88095ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:38:49.54189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:38:47.846207Z","time spent":"1.69566965s","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T03:38:49.542328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:38:48.218406Z","time spent":"1.323605853s","remote":"127.0.0.1:43294","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:38:49.592827Z","caller":"traceutil/trace.go:171","msg":"trace[1182485778] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"229.600065ms","start":"2026-06-26T03:38:49.363188Z","end":"2026-06-26T03:38:49.592788Z","steps":["trace[1182485778] 'process raft request' (duration: 229.39148ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:06.049544Z","caller":"traceutil/trace.go:171","msg":"trace[1153638298] linearizableReadLoop","detail":"{readStateIndex:1370; appliedIndex:1369; }","duration":"382.989562ms","start":"2026-06-26T03:39:05.666536Z","end":"2026-06-26T03:39:06.049526Z","steps":["trace[1153638298] 'read index received' (duration: 382.947231ms)","trace[1153638298] 'applied index is now lower than readState.Index' (duration: 41.611µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:39:06.049675Z","caller":"traceutil/trace.go:171","msg":"trace[410570619] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"621.856815ms","start":"2026-06-26T03:39:05.427785Z","end":"2026-06-26T03:39:06.049642Z","steps":["trace[410570619] 'process raft request' (duration: 621.629099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:06.049775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:05.427763Z","time spent":"621.939748ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:39:06.050007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.360559ms","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-06-26T03:39:06.050086Z","caller":"traceutil/trace.go:171","msg":"trace[511711599] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1311; }","duration":"366.479893ms","start":"2026-06-26T03:39:05.683588Z","end":"2026-06-26T03:39:06.050067Z","steps":["trace[511711599] 'agreement among raft nodes before linearized reading' (duration: 366.261087ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:06.050113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.54338ms","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-06-26T03:39:06.050127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:05.683576Z","time spent":"366.542194ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-26T03:39:06.050142Z","caller":"traceutil/trace.go:171","msg":"trace[1300784564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1311; }","duration":"359.594251ms","start":"2026-06-26T03:39:05.690541Z","end":"2026-06-26T03:39:06.050135Z","steps":["trace[1300784564] 'agreement among raft nodes before linearized reading' (duration: 359.496188ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:06.050166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:05.69053Z","time spent":"359.631073ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T03:39:06.050276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.012997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-26T03:39:06.050307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.778483ms","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-06-26T03:39:06.050306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.715232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T03:39:06.050317Z","caller":"traceutil/trace.go:171","msg":"trace[922051310] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1311; }","duration":"363.058147ms","start":"2026-06-26T03:39:05.687247Z","end":"2026-06-26T03:39:06.050305Z","steps":["trace[922051310] 'agreement among raft nodes before linearized reading' (duration: 362.970875ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:06.050351Z","caller":"traceutil/trace.go:171","msg":"trace[615604749] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1311; }","duration":"360.776484ms","start":"2026-06-26T03:39:05.689562Z","end":"2026-06-26T03:39:06.050339Z","steps":["trace[615604749] 'agreement among raft nodes before linearized reading' (duration: 360.642141ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:06.050365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:05.687242Z","time spent":"363.113739ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T03:39:06.050391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:05.689556Z","time spent":"360.828406ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-26T03:39:06.050337Z","caller":"traceutil/trace.go:171","msg":"trace[1257865530] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1311; }","duration":"383.843156ms","start":"2026-06-26T03:39:05.666487Z","end":"2026-06-26T03:39:06.05033Z","steps":["trace[1257865530] 'agreement among raft nodes before linearized reading' (duration: 383.775335ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:06.050511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:05.666466Z","time spent":"384.038591ms","remote":"127.0.0.1:43550","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-06-26T03:39:20.737844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.485941ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:39:20.738017Z","caller":"traceutil/trace.go:171","msg":"trace[973046976] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"347.112394ms","start":"2026-06-26T03:39:20.390889Z","end":"2026-06-26T03:39:20.738001Z","steps":["trace[973046976] 'process raft request' (duration: 167.395805ms)","trace[973046976] 'compare' (duration: 179.337828ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:39:20.738231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:20.390865Z","time spent":"347.183247ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:39:21.243184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.489239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:39:21.243414Z","caller":"traceutil/trace.go:171","msg":"trace[1634915595] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1371; }","duration":"354.780767ms","start":"2026-06-26T03:39:20.888607Z","end":"2026-06-26T03:39:21.243388Z","steps":["trace[1634915595] 'range keys from in-memory index tree' (duration: 354.418377ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:21.243566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:20.888587Z","time spent":"354.961252ms","remote":"127.0.0.1:43274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T03:39:22.762995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.94184ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:39:22.763059Z","caller":"traceutil/trace.go:171","msg":"trace[1918657245] linearizableReadLoop","detail":"{readStateIndex:1436; appliedIndex:1435; }","duration":"593.459225ms","start":"2026-06-26T03:39:22.169589Z","end":"2026-06-26T03:39:22.763048Z","steps":["trace[1918657245] 'read index received' (duration: 18.35245ms)","trace[1918657245] 'applied index is now lower than readState.Index' (duration: 575.106155ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:39:22.763176Z","caller":"traceutil/trace.go:171","msg":"trace[161707798] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"616.160696ms","start":"2026-06-26T03:39:22.147009Z","end":"2026-06-26T03:39:22.76317Z","steps":["trace[161707798] 'process raft request' (duration: 40.99199ms)","trace[161707798] 'compare' (duration: 574.685873ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:39:22.763211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:22.146985Z","time spent":"616.210079ms","remote":"127.0.0.1:43550","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-06-26T03:39:22.763382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.802694ms","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-06-26T03:39:22.763402Z","caller":"traceutil/trace.go:171","msg":"trace[195024212] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1374; }","duration":"593.863556ms","start":"2026-06-26T03:39:22.169533Z","end":"2026-06-26T03:39:22.763397Z","steps":["trace[195024212] 'agreement among raft nodes before linearized reading' (duration: 593.762274ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:22.763416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:22.169516Z","time spent":"593.897128ms","remote":"127.0.0.1:43550","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-06-26T03:39:22.894251Z","caller":"traceutil/trace.go:171","msg":"trace[1679032560] linearizableReadLoop","detail":"{readStateIndex:1437; appliedIndex:1436; }","duration":"131.160629ms","start":"2026-06-26T03:39:22.763072Z","end":"2026-06-26T03:39:22.894233Z","steps":["trace[1679032560] 'read index received' (duration: 48.714806ms)","trace[1679032560] 'applied index is now lower than readState.Index' (duration: 82.443992ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:39:22.894354Z","caller":"traceutil/trace.go:171","msg":"trace[592205208] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"120.733967ms","start":"2026-06-26T03:39:22.773599Z","end":"2026-06-26T03:39:22.894333Z","steps":["trace[592205208] 'process raft request' (duration: 120.690137ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:22.894444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.69021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5330"} {"level":"warn","ts":"2026-06-26T03:39:22.894448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.892794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-26T03:39:22.894468Z","caller":"traceutil/trace.go:171","msg":"trace[598144551] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1376; }","duration":"443.748801ms","start":"2026-06-26T03:39:22.450712Z","end":"2026-06-26T03:39:22.89446Z","steps":["trace[598144551] 'agreement among raft nodes before linearized reading' (duration: 443.618547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:22.89449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:22.450698Z","time spent":"443.787413ms","remote":"127.0.0.1:43446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":5352,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-06-26T03:39:22.894493Z","caller":"traceutil/trace.go:171","msg":"trace[2108951963] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1376; }","duration":"686.959726ms","start":"2026-06-26T03:39:22.20752Z","end":"2026-06-26T03:39:22.89448Z","steps":["trace[2108951963] 'agreement among raft nodes before linearized reading' (duration: 686.813381ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:22.894533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:22.207515Z","time spent":"687.004797ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T03:39:22.894628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.128221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-26T03:39:22.894646Z","caller":"traceutil/trace.go:171","msg":"trace[783150981] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1376; }","duration":"687.160072ms","start":"2026-06-26T03:39:22.20748Z","end":"2026-06-26T03:39:22.89464Z","steps":["trace[783150981] 'agreement among raft nodes before linearized reading' (duration: 687.106511ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:22.894642Z","caller":"traceutil/trace.go:171","msg":"trace[1537816276] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"125.49368ms","start":"2026-06-26T03:39:22.769137Z","end":"2026-06-26T03:39:22.894631Z","steps":["trace[1537816276] 'process raft request' (duration: 125.039527ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:22.894662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:22.207474Z","time spent":"687.184642ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T03:39:22.894798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.342088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-06-26T03:39:22.894803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.995095ms","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-06-26T03:39:22.894839Z","caller":"traceutil/trace.go:171","msg":"trace[2110334123] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1376; }","duration":"450.074358ms","start":"2026-06-26T03:39:22.444753Z","end":"2026-06-26T03:39:22.894828Z","steps":["trace[2110334123] 'agreement among raft nodes before linearized reading' (duration: 450.012695ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:22.894871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:22.444721Z","time spent":"450.14136ms","remote":"127.0.0.1:43770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-06-26T03:39:22.894882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.552498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:39:22.894918Z","caller":"traceutil/trace.go:171","msg":"trace[1340198126] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1376; }","duration":"602.646001ms","start":"2026-06-26T03:39:22.292261Z","end":"2026-06-26T03:39:22.894907Z","steps":["trace[1340198126] 'agreement among raft nodes before linearized reading' (duration: 602.587759ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:22.89495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:22.29224Z","time spent":"602.700513ms","remote":"127.0.0.1:43338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"info","ts":"2026-06-26T03:39:22.894814Z","caller":"traceutil/trace.go:171","msg":"trace[565103056] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1376; }","duration":"687.394528ms","start":"2026-06-26T03:39:22.207415Z","end":"2026-06-26T03:39:22.894809Z","steps":["trace[565103056] 'agreement among raft nodes before linearized reading' (duration: 687.285215ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:22.895099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:22.207391Z","time spent":"687.698806ms","remote":"127.0.0.1:43550","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":"warn","ts":"2026-06-26T03:39:22.89514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.563773ms","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-06-26T03:39:22.895167Z","caller":"traceutil/trace.go:171","msg":"trace[552297111] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1376; }","duration":"687.601835ms","start":"2026-06-26T03:39:22.207557Z","end":"2026-06-26T03:39:22.895159Z","steps":["trace[552297111] 'agreement among raft nodes before linearized reading' (duration: 687.516342ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:22.895192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:22.207551Z","time spent":"687.635735ms","remote":"127.0.0.1:43550","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":"info","ts":"2026-06-26T03:39:23.051019Z","caller":"traceutil/trace.go:171","msg":"trace[1953230253] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"149.716064ms","start":"2026-06-26T03:39:22.901278Z","end":"2026-06-26T03:39:23.050994Z","steps":["trace[1953230253] 'process raft request' (duration: 149.636491ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:23.051033Z","caller":"traceutil/trace.go:171","msg":"trace[119251008] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"149.818477ms","start":"2026-06-26T03:39:22.901181Z","end":"2026-06-26T03:39:23.051Z","steps":["trace[119251008] 'process raft request' (duration: 96.645728ms)","trace[119251008] 'compare' (duration: 52.955933ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:39:23.051371Z","caller":"traceutil/trace.go:171","msg":"trace[1793717883] transaction","detail":"{read_only:false; response_revision:1380; number_of_response:1; }","duration":"150.029042ms","start":"2026-06-26T03:39:22.90133Z","end":"2026-06-26T03:39:23.051359Z","steps":["trace[1793717883] 'process raft request' (duration: 149.626642ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:23.051969Z","caller":"traceutil/trace.go:171","msg":"trace[167768368] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"150.519846ms","start":"2026-06-26T03:39:22.901424Z","end":"2026-06-26T03:39:23.051943Z","steps":["trace[167768368] 'process raft request' (duration: 149.891589ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:23.05268Z","caller":"traceutil/trace.go:171","msg":"trace[548966593] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"148.970053ms","start":"2026-06-26T03:39:22.903694Z","end":"2026-06-26T03:39:23.052664Z","steps":["trace[548966593] 'process raft request' (duration: 148.218222ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:23.214263Z","caller":"traceutil/trace.go:171","msg":"trace[722348790] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"155.055773ms","start":"2026-06-26T03:39:23.059185Z","end":"2026-06-26T03:39:23.214241Z","steps":["trace[722348790] 'process raft request' (duration: 138.308937ms)","trace[722348790] 'compare' (duration: 16.641023ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:39:24.905514Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515235535911475997,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T03:39:25.406182Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515235535911475997,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T03:39:25.907197Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515235535911475997,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T03:39:26.055044Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.428879263s","expected-duration":"1s"} {"level":"info","ts":"2026-06-26T03:39:26.055442Z","caller":"traceutil/trace.go:171","msg":"trace[1868033015] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"2.429328055s","start":"2026-06-26T03:39:23.626083Z","end":"2026-06-26T03:39:26.055411Z","steps":["trace[1868033015] 'process raft request' (duration: 2.429156241s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.055591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:23.62606Z","time spent":"2.429445049s","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:39:26.088461Z","caller":"traceutil/trace.go:171","msg":"trace[1880394556] linearizableReadLoop","detail":"{readStateIndex:1448; appliedIndex:1446; }","duration":"2.207186008s","start":"2026-06-26T03:39:23.881253Z","end":"2026-06-26T03:39:26.088439Z","steps":["trace[1880394556] 'read index received' (duration: 2.173977355s)","trace[1880394556] 'applied index is now lower than readState.Index' (duration: 33.207753ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:39:26.088573Z","caller":"traceutil/trace.go:171","msg":"trace[1044157000] transaction","detail":"{read_only:false; response_revision:1385; number_of_response:1; }","duration":"1.174125485s","start":"2026-06-26T03:39:24.914429Z","end":"2026-06-26T03:39:26.088554Z","steps":["trace[1044157000] 'process raft request' (duration: 1.173906309s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.088625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.207351483s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:39:26.088658Z","caller":"traceutil/trace.go:171","msg":"trace[932746767] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1385; }","duration":"2.207424784s","start":"2026-06-26T03:39:23.881224Z","end":"2026-06-26T03:39:26.088649Z","steps":["trace[932746767] 'agreement among raft nodes before linearized reading' (duration: 2.207331331s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.088662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:24.914409Z","time spent":"1.174200347s","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:39:26.088686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:23.881211Z","time spent":"2.207466566s","remote":"127.0.0.1:43522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"warn","ts":"2026-06-26T03:39:26.088723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.182137369s","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-06-26T03:39:26.088755Z","caller":"traceutil/trace.go:171","msg":"trace[2033882473] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1385; }","duration":"1.18217959s","start":"2026-06-26T03:39:24.906567Z","end":"2026-06-26T03:39:26.088747Z","steps":["trace[2033882473] 'agreement among raft nodes before linearized reading' (duration: 1.182078427s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.088776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:24.906563Z","time spent":"1.18220743s","remote":"127.0.0.1:43550","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":"warn","ts":"2026-06-26T03:39:26.088837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.179582907s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T03:39:26.088826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.034340868s","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-06-26T03:39:26.088914Z","caller":"traceutil/trace.go:171","msg":"trace[342442874] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1385; }","duration":"1.034438991s","start":"2026-06-26T03:39:25.054452Z","end":"2026-06-26T03:39:26.088891Z","steps":["trace[342442874] 'agreement among raft nodes before linearized reading' (duration: 1.034256036s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.088944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.518706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-26T03:39:26.088961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.03331507s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-06-26T03:39:26.08896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.033388952s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-26T03:39:26.088969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:25.054408Z","time spent":"1.034548024s","remote":"127.0.0.1:43550","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-06-26T03:39:26.088995Z","caller":"traceutil/trace.go:171","msg":"trace[1492643501] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1385; }","duration":"1.03336822s","start":"2026-06-26T03:39:25.055617Z","end":"2026-06-26T03:39:26.088985Z","steps":["trace[1492643501] 'agreement among raft nodes before linearized reading' (duration: 1.033271827s)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:26.088996Z","caller":"traceutil/trace.go:171","msg":"trace[155082717] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1385; }","duration":"694.593029ms","start":"2026-06-26T03:39:25.394386Z","end":"2026-06-26T03:39:26.088979Z","steps":["trace[155082717] 'agreement among raft nodes before linearized reading' (duration: 694.488916ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:26.089001Z","caller":"traceutil/trace.go:171","msg":"trace[223999676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1385; }","duration":"1.033440972s","start":"2026-06-26T03:39:25.05555Z","end":"2026-06-26T03:39:26.088991Z","steps":["trace[223999676] 'agreement among raft nodes before linearized reading' (duration: 1.03334092s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.08882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.034224995s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-26T03:39:26.089022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:25.055607Z","time spent":"1.033408371s","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T03:39:26.089036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:25.055545Z","time spent":"1.033484265s","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-26T03:39:26.089045Z","caller":"traceutil/trace.go:171","msg":"trace[166148665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1385; }","duration":"1.034495502s","start":"2026-06-26T03:39:25.054542Z","end":"2026-06-26T03:39:26.089038Z","steps":["trace[166148665] 'agreement among raft nodes before linearized reading' (duration: 1.034092021s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.089042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:25.394375Z","time spent":"694.652791ms","remote":"127.0.0.1:43306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":31,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-06-26T03:39:26.089069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:25.054529Z","time spent":"1.034532683s","remote":"127.0.0.1:43550","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-06-26T03:39:26.088826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.182879149s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:39:26.088859Z","caller":"traceutil/trace.go:171","msg":"trace[445554246] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1385; }","duration":"1.179614448s","start":"2026-06-26T03:39:24.909239Z","end":"2026-06-26T03:39:26.088853Z","steps":["trace[445554246] 'agreement among raft nodes before linearized reading' (duration: 1.179584187s)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:26.089106Z","caller":"traceutil/trace.go:171","msg":"trace[505017061] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1385; }","duration":"1.183195387s","start":"2026-06-26T03:39:24.905898Z","end":"2026-06-26T03:39:26.089093Z","steps":["trace[505017061] 'agreement among raft nodes before linearized reading' (duration: 1.182841618s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.089113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:24.909232Z","time spent":"1.179877575s","remote":"127.0.0.1:43274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T03:39:26.089122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.019083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T03:39:26.089139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:24.905895Z","time spent":"1.183232668s","remote":"127.0.0.1:55640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-26T03:39:26.089148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.183288141s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T03:39:26.089172Z","caller":"traceutil/trace.go:171","msg":"trace[203360716] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1385; }","duration":"753.105996ms","start":"2026-06-26T03:39:25.336051Z","end":"2026-06-26T03:39:26.089157Z","steps":["trace[203360716] 'agreement among raft nodes before linearized reading' (duration: 753.024104ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:26.089192Z","caller":"traceutil/trace.go:171","msg":"trace[2081017771] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1385; }","duration":"1.183356222s","start":"2026-06-26T03:39:24.905823Z","end":"2026-06-26T03:39:26.089179Z","steps":["trace[2081017771] 'agreement among raft nodes before linearized reading' (duration: 1.183268179s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.089214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:25.336028Z","time spent":"753.175777ms","remote":"127.0.0.1:55816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-06-26T03:39:26.089233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:24.905809Z","time spent":"1.183412104s","remote":"127.0.0.1:43726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-06-26T03:39:26.089387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.101864618s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:39:26.089418Z","caller":"traceutil/trace.go:171","msg":"trace[1553119939] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1385; }","duration":"2.101922149s","start":"2026-06-26T03:39:23.987486Z","end":"2026-06-26T03:39:26.089408Z","steps":["trace[1553119939] 'agreement among raft nodes before linearized reading' (duration: 2.101129797s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.089441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:23.987472Z","time spent":"2.101963571s","remote":"127.0.0.1:55714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-26T03:39:26.280253Z","caller":"traceutil/trace.go:171","msg":"trace[1658302417] transaction","detail":"{read_only:false; response_revision:1386; number_of_response:1; }","duration":"186.63087ms","start":"2026-06-26T03:39:26.093594Z","end":"2026-06-26T03:39:26.280225Z","steps":["trace[1658302417] 'process raft request' (duration: 133.018429ms)","trace[1658302417] 'compare' (duration: 53.427836ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:39:26.310765Z","caller":"traceutil/trace.go:171","msg":"trace[1309533288] transaction","detail":"{read_only:false; response_revision:1388; number_of_response:1; }","duration":"216.754519ms","start":"2026-06-26T03:39:26.093975Z","end":"2026-06-26T03:39:26.31073Z","steps":["trace[1309533288] 'process raft request' (duration: 216.678116ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:26.311106Z","caller":"traceutil/trace.go:171","msg":"trace[829491998] transaction","detail":"{read_only:false; response_revision:1387; number_of_response:1; }","duration":"217.219291ms","start":"2026-06-26T03:39:26.093594Z","end":"2026-06-26T03:39:26.310813Z","steps":["trace[829491998] 'process raft request' (duration: 216.927233ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:26.311724Z","caller":"traceutil/trace.go:171","msg":"trace[2048123016] transaction","detail":"{read_only:false; response_revision:1389; number_of_response:1; }","duration":"217.637203ms","start":"2026-06-26T03:39:26.094055Z","end":"2026-06-26T03:39:26.311693Z","steps":["trace[2048123016] 'process raft request' (duration: 216.630436ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:26.311818Z","caller":"traceutil/trace.go:171","msg":"trace[1249098660] transaction","detail":"{read_only:false; response_revision:1390; number_of_response:1; }","duration":"217.709075ms","start":"2026-06-26T03:39:26.094095Z","end":"2026-06-26T03:39:26.311804Z","steps":["trace[1249098660] 'process raft request' (duration: 217.588421ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:26.311813Z","caller":"traceutil/trace.go:171","msg":"trace[1517304030] linearizableReadLoop","detail":"{readStateIndex:1453; appliedIndex:1448; }","duration":"215.533934ms","start":"2026-06-26T03:39:26.096267Z","end":"2026-06-26T03:39:26.311801Z","steps":["trace[1517304030] 'read index received' (duration: 130.292434ms)","trace[1517304030] 'applied index is now lower than readState.Index' (duration: 85.24086ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:39:26.31205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.767161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:39:26.31229Z","caller":"traceutil/trace.go:171","msg":"trace[647063213] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1390; }","duration":"216.042938ms","start":"2026-06-26T03:39:26.096237Z","end":"2026-06-26T03:39:26.31228Z","steps":["trace[647063213] 'agreement among raft nodes before linearized reading' (duration: 215.77305ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.796515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.012011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:39:26.796604Z","caller":"traceutil/trace.go:171","msg":"trace[1155241131] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1390; }","duration":"384.172086ms","start":"2026-06-26T03:39:26.412414Z","end":"2026-06-26T03:39:26.796586Z","steps":["trace[1155241131] 'count revisions from in-memory index tree' (duration: 383.841636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.796652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:26.412394Z","time spent":"384.240667ms","remote":"127.0.0.1:43578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"info","ts":"2026-06-26T03:39:36.244327Z","caller":"traceutil/trace.go:171","msg":"trace[711275604] transaction","detail":"{read_only:false; response_revision:1467; number_of_response:1; }","duration":"117.409445ms","start":"2026-06-26T03:39:36.126898Z","end":"2026-06-26T03:39:36.244307Z","steps":["trace[711275604] 'process raft request' (duration: 117.293912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:36.867892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.516583ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:39:36.868094Z","caller":"traceutil/trace.go:171","msg":"trace[1518757148] linearizableReadLoop","detail":"{readStateIndex:1534; appliedIndex:1532; }","duration":"488.017233ms","start":"2026-06-26T03:39:36.380058Z","end":"2026-06-26T03:39:36.868075Z","steps":["trace[1518757148] 'read index received' (duration: 99.181219ms)","trace[1518757148] 'applied index is now lower than readState.Index' (duration: 388.835044ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:39:36.868095Z","caller":"traceutil/trace.go:171","msg":"trace[1830373960] transaction","detail":"{read_only:false; response_revision:1468; number_of_response:1; }","duration":"537.780167ms","start":"2026-06-26T03:39:36.330279Z","end":"2026-06-26T03:39:36.868059Z","steps":["trace[1830373960] 'process raft request' (duration: 46.998757ms)","trace[1830373960] 'compare' (duration: 490.162823ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:39:36.868232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:36.330264Z","time spent":"537.891011ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:39:36.868319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.24325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-26T03:39:36.868382Z","caller":"traceutil/trace.go:171","msg":"trace[2063667420] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1469; }","duration":"488.332172ms","start":"2026-06-26T03:39:36.380031Z","end":"2026-06-26T03:39:36.868364Z","steps":["trace[2063667420] 'agreement among raft nodes before linearized reading' (duration: 488.148586ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:36.868413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.114636ms","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-06-26T03:39:36.868448Z","caller":"traceutil/trace.go:171","msg":"trace[1429072396] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1469; }","duration":"488.174318ms","start":"2026-06-26T03:39:36.380263Z","end":"2026-06-26T03:39:36.868438Z","steps":["trace[1429072396] 'agreement among raft nodes before linearized reading' (duration: 488.046165ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:36.868455Z","caller":"traceutil/trace.go:171","msg":"trace[1255024888] transaction","detail":"{read_only:false; response_revision:1469; number_of_response:1; }","duration":"498.682251ms","start":"2026-06-26T03:39:36.36976Z","end":"2026-06-26T03:39:36.868442Z","steps":["trace[1255024888] 'process raft request' (duration: 498.228809ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:36.868481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:36.380249Z","time spent":"488.224229ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T03:39:36.868527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:36.369741Z","time spent":"498.738462ms","remote":"127.0.0.1:43550","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-06-26T03:39:36.868417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:36.380021Z","time spent":"488.389323ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T03:39:36.868723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.937134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T03:39:36.868757Z","caller":"traceutil/trace.go:171","msg":"trace[620410531] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1469; }","duration":"331.005857ms","start":"2026-06-26T03:39:36.537739Z","end":"2026-06-26T03:39:36.868745Z","steps":["trace[620410531] 'agreement among raft nodes before linearized reading' (duration: 330.930044ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:36.868786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:36.537719Z","time spent":"331.058938ms","remote":"127.0.0.1:43660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":55,"response size":29,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-06-26T03:39:36.868807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.574746ms","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-06-26T03:39:36.868839Z","caller":"traceutil/trace.go:171","msg":"trace[688678840] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1469; }","duration":"485.641297ms","start":"2026-06-26T03:39:36.383188Z","end":"2026-06-26T03:39:36.868829Z","steps":["trace[688678840] 'agreement among raft nodes before linearized reading' (duration: 485.560606ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:36.868859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:36.383182Z","time spent":"485.672049ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T03:39:36.868955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.632961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T03:39:36.868976Z","caller":"traceutil/trace.go:171","msg":"trace[854166219] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1469; }","duration":"488.666912ms","start":"2026-06-26T03:39:36.380303Z","end":"2026-06-26T03:39:36.86897Z","steps":["trace[854166219] 'agreement among raft nodes before linearized reading' (duration: 488.60669ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:36.868995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:36.380297Z","time spent":"488.692242ms","remote":"127.0.0.1:43550","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-06-26T03:39:37.388749Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515235535911476155,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T03:39:37.889289Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515235535911476155,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T03:39:38.389833Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515235535911476155,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T03:39:38.744177Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.869964133s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-26T03:39:38.860475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.872423ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:39:38.860593Z","caller":"traceutil/trace.go:171","msg":"trace[1159126422] transaction","detail":"{read_only:false; response_revision:1470; number_of_response:1; }","duration":"1.986445951s","start":"2026-06-26T03:39:36.874128Z","end":"2026-06-26T03:39:38.860574Z","steps":["trace[1159126422] 'process raft request' (duration: 1.870349482s)","trace[1159126422] 'compare' (duration: 115.07513ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:39:38.860658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:36.874111Z","time spent":"1.986514064s","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:39:38.888953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000456521s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-26T03:39:38.889025Z","caller":"traceutil/trace.go:171","msg":"trace[139438806] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000583785s","start":"2026-06-26T03:39:36.888425Z","end":"2026-06-26T03:39:38.889008Z","steps":["trace[139438806] 'agreement among raft nodes before linearized reading' (duration: 2.000477192s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:38.889065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:36.888416Z","time spent":"2.000640896s","remote":"127.0.0.1:43274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/26 03:39:38 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-06-26T03:39:39.503262Z","caller":"traceutil/trace.go:171","msg":"trace[346895896] transaction","detail":"{read_only:false; response_revision:1471; number_of_response:1; }","duration":"2.62886837s","start":"2026-06-26T03:39:36.874373Z","end":"2026-06-26T03:39:39.503241Z","steps":["trace[346895896] 'process raft request' (duration: 2.628707546s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:39.503437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:36.874348Z","time spent":"2.628983193s","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:39:39.50358Z","caller":"traceutil/trace.go:171","msg":"trace[552596661] transaction","detail":"{read_only:false; response_revision:1472; number_of_response:1; }","duration":"2.628112669s","start":"2026-06-26T03:39:36.875442Z","end":"2026-06-26T03:39:39.503555Z","steps":["trace[552596661] 'process raft request' (duration: 2.6277657s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:39.503804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:36.875423Z","time spent":"2.628216722s","remote":"127.0.0.1:43550","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-06-26T03:39:39.504278Z","caller":"traceutil/trace.go:171","msg":"trace[1570485269] transaction","detail":"{read_only:false; response_revision:1473; number_of_response:1; }","duration":"2.628780568s","start":"2026-06-26T03:39:36.875475Z","end":"2026-06-26T03:39:39.504256Z","steps":["trace[1570485269] 'process raft request' (duration: 2.627980315s)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:39.504561Z","caller":"traceutil/trace.go:171","msg":"trace[272275363] transaction","detail":"{read_only:false; response_revision:1474; number_of_response:1; }","duration":"2.628538121s","start":"2026-06-26T03:39:36.876001Z","end":"2026-06-26T03:39:39.504539Z","steps":["trace[272275363] 'process raft request' (duration: 2.628213132s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:39.504655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:36.875464Z","time spent":"2.629115218s","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:39:39.504709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:36.875994Z","time spent":"2.628637064s","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:39:39.50507Z","caller":"traceutil/trace.go:171","msg":"trace[1704357312] transaction","detail":"{read_only:false; response_revision:1475; number_of_response:1; }","duration":"1.254806722s","start":"2026-06-26T03:39:38.250249Z","end":"2026-06-26T03:39:39.505056Z","steps":["trace[1704357312] 'process raft request' (duration: 1.254172094s)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:39.505057Z","caller":"traceutil/trace.go:171","msg":"trace[1268368316] linearizableReadLoop","detail":"{readStateIndex:1540; appliedIndex:1534; }","duration":"2.616587308s","start":"2026-06-26T03:39:36.888454Z","end":"2026-06-26T03:39:39.505041Z","steps":["trace[1268368316] 'read index received' (duration: 1.855992853s)","trace[1268368316] 'applied index is now lower than readState.Index' (duration: 760.593425ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:39:39.505147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:38.25023Z","time spent":"1.254879674s","remote":"127.0.0.1:43550","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-06-26T03:39:39.50531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.218472225s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:39:39.505367Z","caller":"traceutil/trace.go:171","msg":"trace[1187136992] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1475; }","duration":"2.218535347s","start":"2026-06-26T03:39:37.286821Z","end":"2026-06-26T03:39:39.505357Z","steps":["trace[1187136992] 'agreement among raft nodes before linearized reading' (duration: 2.218390653s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:39.505399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:37.286764Z","time spent":"2.2186265s","remote":"127.0.0.1:43488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-06-26T03:39:39.505456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"960.359602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-06-26T03:39:39.505491Z","caller":"traceutil/trace.go:171","msg":"trace[896769582] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1475; }","duration":"960.432824ms","start":"2026-06-26T03:39:38.545048Z","end":"2026-06-26T03:39:39.50548Z","steps":["trace[896769582] 'agreement among raft nodes before linearized reading' (duration: 960.31258ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:39.50552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:38.545017Z","time spent":"960.496405ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-26T03:39:39.505612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.834195467s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.14\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-06-26T03:39:39.50566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.420295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-26T03:39:39.505666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.857764293s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-26T03:39:39.505671Z","caller":"traceutil/trace.go:171","msg":"trace[1433854192] range","detail":"{range_begin:/registry/masterleases/199.19.213.14; range_end:; response_count:1; response_revision:1475; }","duration":"1.834333991s","start":"2026-06-26T03:39:37.671322Z","end":"2026-06-26T03:39:39.505656Z","steps":["trace[1433854192] 'agreement among raft nodes before linearized reading' (duration: 1.834119575s)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:39.505689Z","caller":"traceutil/trace.go:171","msg":"trace[600901925] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1475; }","duration":"223.488195ms","start":"2026-06-26T03:39:39.282192Z","end":"2026-06-26T03:39:39.505681Z","steps":["trace[600901925] 'agreement among raft nodes before linearized reading' (duration: 223.440523ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:39.505698Z","caller":"traceutil/trace.go:171","msg":"trace[245722529] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1475; }","duration":"1.857829574s","start":"2026-06-26T03:39:37.647856Z","end":"2026-06-26T03:39:39.505686Z","steps":["trace[245722529] 'agreement among raft nodes before linearized reading' (duration: 1.857707361s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:39.505728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:37.647837Z","time spent":"1.857884595s","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-26T03:39:39.50574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.037907158s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:39:39.505766Z","caller":"traceutil/trace.go:171","msg":"trace[797208720] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1475; }","duration":"1.037970952s","start":"2026-06-26T03:39:38.467788Z","end":"2026-06-26T03:39:39.505759Z","steps":["trace[797208720] 'agreement among raft nodes before linearized reading' (duration: 1.03793201s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:39.505785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:38.467763Z","time spent":"1.038016922s","remote":"127.0.0.1:55558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-06-26T03:39:39.505853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.113412553s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T03:39:39.505898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.426845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:39:39.505935Z","caller":"traceutil/trace.go:171","msg":"trace[87124969] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1475; }","duration":"616.490117ms","start":"2026-06-26T03:39:38.889433Z","end":"2026-06-26T03:39:39.505923Z","steps":["trace[87124969] 'agreement among raft nodes before linearized reading' (duration: 616.431806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:39.505962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:38.889419Z","time spent":"616.537047ms","remote":"127.0.0.1:43276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T03:39:39.505992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.423172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T03:39:39.506027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.322514725s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:472"} {"level":"info","ts":"2026-06-26T03:39:39.506041Z","caller":"traceutil/trace.go:171","msg":"trace[793302169] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1475; }","duration":"837.501875ms","start":"2026-06-26T03:39:38.668526Z","end":"2026-06-26T03:39:39.506028Z","steps":["trace[793302169] 'agreement among raft nodes before linearized reading' (duration: 837.414992ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:39.506079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:38.668507Z","time spent":"837.563355ms","remote":"127.0.0.1:55644","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-06-26T03:39:39.506131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.226661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-26T03:39:39.505901Z","caller":"traceutil/trace.go:171","msg":"trace[155528035] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1475; }","duration":"2.113507776s","start":"2026-06-26T03:39:37.392379Z","end":"2026-06-26T03:39:39.505887Z","steps":["trace[155528035] 'agreement among raft nodes before linearized reading' (duration: 2.113421423s)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:39.506161Z","caller":"traceutil/trace.go:171","msg":"trace[1464455256] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1475; }","duration":"629.300763ms","start":"2026-06-26T03:39:38.876852Z","end":"2026-06-26T03:39:39.506153Z","steps":["trace[1464455256] 'agreement among raft nodes before linearized reading' (duration: 629.19019ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:39.50618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:37.392354Z","time spent":"2.113812893s","remote":"127.0.0.1:55802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-26T03:39:39.506185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:38.876835Z","time spent":"629.344033ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-26T03:39:39.50605Z","caller":"traceutil/trace.go:171","msg":"trace[1329247502] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1475; }","duration":"1.322570317s","start":"2026-06-26T03:39:38.183474Z","end":"2026-06-26T03:39:39.506044Z","steps":["trace[1329247502] 'agreement among raft nodes before linearized reading' (duration: 1.322505806s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:39.506233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:38.183456Z","time spent":"1.322762492s","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":494,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-26T03:39:39.505703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:37.671311Z","time spent":"1.834387553s","remote":"127.0.0.1:43294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.19.213.14\" "} {"level":"info","ts":"2026-06-26T03:39:39.701776Z","caller":"traceutil/trace.go:171","msg":"trace[651026619] transaction","detail":"{read_only:false; response_revision:1476; number_of_response:1; }","duration":"191.048304ms","start":"2026-06-26T03:39:39.510698Z","end":"2026-06-26T03:39:39.701747Z","steps":["trace[651026619] 'process raft request' (duration: 179.998947ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:39.701812Z","caller":"traceutil/trace.go:171","msg":"trace[1736036848] linearizableReadLoop","detail":"{readStateIndex:1546; appliedIndex:1540; }","duration":"189.177282ms","start":"2026-06-26T03:39:39.512618Z","end":"2026-06-26T03:39:39.701795Z","steps":["trace[1736036848] 'read index received' (duration: 57.236262ms)","trace[1736036848] 'applied index is now lower than readState.Index' (duration: 131.9401ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:39:39.701856Z","caller":"traceutil/trace.go:171","msg":"trace[946630255] transaction","detail":"{read_only:false; response_revision:1477; number_of_response:1; }","duration":"191.020273ms","start":"2026-06-26T03:39:39.510786Z","end":"2026-06-26T03:39:39.701806Z","steps":["trace[946630255] 'process raft request' (duration: 190.848638ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:39.701926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.299835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:39:39.701956Z","caller":"traceutil/trace.go:171","msg":"trace[2055330150] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1480; }","duration":"189.355697ms","start":"2026-06-26T03:39:39.512591Z","end":"2026-06-26T03:39:39.701947Z","steps":["trace[2055330150] 'agreement among raft nodes before linearized reading' (duration: 189.270435ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:39.702012Z","caller":"traceutil/trace.go:171","msg":"trace[1790017199] transaction","detail":"{read_only:false; response_revision:1478; number_of_response:1; }","duration":"191.160957ms","start":"2026-06-26T03:39:39.510841Z","end":"2026-06-26T03:39:39.702002Z","steps":["trace[1790017199] 'process raft request' (duration: 190.848388ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:39.702061Z","caller":"traceutil/trace.go:171","msg":"trace[1398787121] transaction","detail":"{read_only:false; response_revision:1479; number_of_response:1; }","duration":"191.142887ms","start":"2026-06-26T03:39:39.510885Z","end":"2026-06-26T03:39:39.702028Z","steps":["trace[1398787121] 'process raft request' (duration: 190.844838ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:39.702092Z","caller":"traceutil/trace.go:171","msg":"trace[871122851] transaction","detail":"{read_only:false; response_revision:1480; number_of_response:1; }","duration":"190.753026ms","start":"2026-06-26T03:39:39.511328Z","end":"2026-06-26T03:39:39.702081Z","steps":["trace[871122851] 'process raft request' (duration: 190.432637ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:39.702446Z","caller":"traceutil/trace.go:171","msg":"trace[1776025445] transaction","detail":"{read_only:false; response_revision:1481; number_of_response:1; }","duration":"131.498868ms","start":"2026-06-26T03:39:39.570928Z","end":"2026-06-26T03:39:39.702427Z","steps":["trace[1776025445] 'process raft request' (duration: 131.376835ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:16.112687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.685589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-26T03:40:16.112759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.498818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-26T03:40:16.112773Z","caller":"traceutil/trace.go:171","msg":"trace[1954523421] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1642; }","duration":"453.820262ms","start":"2026-06-26T03:40:15.658929Z","end":"2026-06-26T03:40:16.112749Z","steps":["trace[1954523421] 'range keys from in-memory index tree' (duration: 453.492684ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:40:16.112809Z","caller":"traceutil/trace.go:171","msg":"trace[1893113287] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1642; }","duration":"236.57182ms","start":"2026-06-26T03:40:15.876221Z","end":"2026-06-26T03:40:16.112793Z","steps":["trace[1893113287] 'range keys from in-memory index tree' (duration: 236.408205ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:16.112815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:15.658906Z","time spent":"453.900665ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T03:40:16.112882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.836179ms","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-06-26T03:40:16.11296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.782805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-26T03:40:16.112977Z","caller":"traceutil/trace.go:171","msg":"trace[1411637799] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1642; }","duration":"450.980102ms","start":"2026-06-26T03:40:15.661978Z","end":"2026-06-26T03:40:16.112958Z","steps":["trace[1411637799] 'range keys from in-memory index tree' (duration: 450.654754ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:40:16.112989Z","caller":"traceutil/trace.go:171","msg":"trace[299740622] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1642; }","duration":"236.844999ms","start":"2026-06-26T03:40:15.876136Z","end":"2026-06-26T03:40:16.112981Z","steps":["trace[299740622] 'range keys from in-memory index tree' (duration: 236.621442ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:16.113024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:15.661959Z","time spent":"451.053085ms","remote":"127.0.0.1:43550","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-06-26T03:40:16.113196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.283117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-26T03:40:16.113237Z","caller":"traceutil/trace.go:171","msg":"trace[2032210032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1642; }","duration":"458.354288ms","start":"2026-06-26T03:40:15.654873Z","end":"2026-06-26T03:40:16.113227Z","steps":["trace[2032210032] 'range keys from in-memory index tree' (duration: 458.169313ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:16.113266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:15.654856Z","time spent":"458.403059ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-26T03:40:17.129689Z","caller":"traceutil/trace.go:171","msg":"trace[310138685] transaction","detail":"{read_only:false; response_revision:1648; number_of_response:1; }","duration":"106.883463ms","start":"2026-06-26T03:40:17.022784Z","end":"2026-06-26T03:40:17.129668Z","steps":["trace[310138685] 'process raft request' (duration: 106.760789ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:18.174001Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515235535911476570,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T03:40:18.470411Z","caller":"traceutil/trace.go:171","msg":"trace[1288155098] transaction","detail":"{read_only:false; response_revision:1649; number_of_response:1; }","duration":"845.368202ms","start":"2026-06-26T03:40:17.62502Z","end":"2026-06-26T03:40:18.470388Z","steps":["trace[1288155098] 'process raft request' (duration: 845.121526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:18.470663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:17.624999Z","time spent":"845.510367ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:40:18.471648Z","caller":"traceutil/trace.go:171","msg":"trace[1080179086] linearizableReadLoop","detail":"{readStateIndex:1723; appliedIndex:1721; }","duration":"797.752849ms","start":"2026-06-26T03:40:17.673861Z","end":"2026-06-26T03:40:18.471614Z","steps":["trace[1080179086] 'read index received' (duration: 796.269998ms)","trace[1080179086] 'applied index is now lower than readState.Index' (duration: 1.481981ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:40:18.471734Z","caller":"traceutil/trace.go:171","msg":"trace[1990716876] transaction","detail":"{read_only:false; response_revision:1650; number_of_response:1; }","duration":"758.484356ms","start":"2026-06-26T03:40:17.713241Z","end":"2026-06-26T03:40:18.471725Z","steps":["trace[1990716876] 'process raft request' (duration: 758.27794ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:18.471832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:17.713222Z","time spent":"758.533988ms","remote":"127.0.0.1:43550","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-06-26T03:40:18.471839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.003504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T03:40:18.471883Z","caller":"traceutil/trace.go:171","msg":"trace[1687027300] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1650; }","duration":"538.080506ms","start":"2026-06-26T03:40:17.933791Z","end":"2026-06-26T03:40:18.471871Z","steps":["trace[1687027300] 'agreement among raft nodes before linearized reading' (duration: 538.008914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:18.471924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:17.933776Z","time spent":"538.139678ms","remote":"127.0.0.1:43782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":29,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-06-26T03:40:18.472144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.295125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.14\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-26T03:40:18.47218Z","caller":"traceutil/trace.go:171","msg":"trace[1486344176] range","detail":"{range_begin:/registry/masterleases/199.19.213.14; range_end:; response_count:1; response_revision:1650; }","duration":"798.370776ms","start":"2026-06-26T03:40:17.6738Z","end":"2026-06-26T03:40:18.472171Z","steps":["trace[1486344176] 'agreement among raft nodes before linearized reading' (duration: 798.261142ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:18.472208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:17.673779Z","time spent":"798.422458ms","remote":"127.0.0.1:43294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.19.213.14\" "} {"level":"warn","ts":"2026-06-26T03:40:18.472231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.693757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T03:40:18.472452Z","caller":"traceutil/trace.go:171","msg":"trace[1600362827] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1650; }","duration":"344.907232ms","start":"2026-06-26T03:40:18.127533Z","end":"2026-06-26T03:40:18.47244Z","steps":["trace[1600362827] 'agreement among raft nodes before linearized reading' (duration: 344.663916ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:18.472497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:18.12749Z","time spent":"345.000636ms","remote":"127.0.0.1:43550","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-06-26T03:40:18.472601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.431878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-26T03:40:18.472627Z","caller":"traceutil/trace.go:171","msg":"trace[1465712214] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1650; }","duration":"345.474949ms","start":"2026-06-26T03:40:18.127146Z","end":"2026-06-26T03:40:18.47262Z","steps":["trace[1465712214] 'agreement among raft nodes before linearized reading' (duration: 345.409087ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:18.472649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:18.127137Z","time spent":"345.506119ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-26T03:40:18.472668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.086025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-26T03:40:18.472731Z","caller":"traceutil/trace.go:171","msg":"trace[1016582948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1650; }","duration":"346.150028ms","start":"2026-06-26T03:40:18.126567Z","end":"2026-06-26T03:40:18.472717Z","steps":["trace[1016582948] 'agreement among raft nodes before linearized reading' (duration: 346.001834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:18.472777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:18.126541Z","time spent":"346.223949ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T03:40:18.472817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.259739ms","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-06-26T03:40:18.472844Z","caller":"traceutil/trace.go:171","msg":"trace[968545615] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1650; }","duration":"347.28763ms","start":"2026-06-26T03:40:18.12555Z","end":"2026-06-26T03:40:18.472838Z","steps":["trace[968545615] 'agreement among raft nodes before linearized reading' (duration: 347.213797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:18.472864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:18.125482Z","time spent":"347.378231ms","remote":"127.0.0.1:43550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T03:40:18.472178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.056218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-26T03:40:18.472912Z","caller":"traceutil/trace.go:171","msg":"trace[439766635] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1650; }","duration":"345.814538ms","start":"2026-06-26T03:40:18.127083Z","end":"2026-06-26T03:40:18.472898Z","steps":["trace[439766635] 'agreement among raft nodes before linearized reading' (duration: 345.009845ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:18.472953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:18.127069Z","time spent":"345.87422ms","remote":"127.0.0.1:43550","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-06-26T03:42:13.316113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.929722ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-26T03:42:13.316235Z","caller":"traceutil/trace.go:171","msg":"trace[795835567] linearizableReadLoop","detail":"{readStateIndex:2274; appliedIndex:2272; }","duration":"217.851876ms","start":"2026-06-26T03:42:13.098365Z","end":"2026-06-26T03:42:13.316216Z","steps":["trace[795835567] 'read index received' (duration: 7.051043ms)","trace[795835567] 'applied index is now lower than readState.Index' (duration: 210.799563ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:42:13.316436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.4579ms","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-06-26T03:42:13.316461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.081792ms","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-06-26T03:42:13.31653Z","caller":"traceutil/trace.go:171","msg":"trace[752094674] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2177; }","duration":"218.202195ms","start":"2026-06-26T03:42:13.098309Z","end":"2026-06-26T03:42:13.316511Z","steps":["trace[752094674] 'agreement among raft nodes before linearized reading' (duration: 217.964509ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:42:13.31657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.736192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-26T03:42:13.316559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.202308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T03:42:13.316611Z","caller":"traceutil/trace.go:171","msg":"trace[1594216458] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2177; }","duration":"202.803073ms","start":"2026-06-26T03:42:13.113799Z","end":"2026-06-26T03:42:13.316602Z","steps":["trace[1594216458] 'agreement among raft nodes before linearized reading' (duration: 202.70779ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:42:13.316659Z","caller":"traceutil/trace.go:171","msg":"trace[2121337382] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2177; }","duration":"194.334312ms","start":"2026-06-26T03:42:13.122293Z","end":"2026-06-26T03:42:13.316627Z","steps":["trace[2121337382] 'agreement among raft nodes before linearized reading' (duration: 194.056854ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:42:13.316475Z","caller":"traceutil/trace.go:171","msg":"trace[300519201] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2177; }","duration":"211.562382ms","start":"2026-06-26T03:42:13.104902Z","end":"2026-06-26T03:42:13.316464Z","steps":["trace[300519201] 'agreement among raft nodes before linearized reading' (duration: 211.411438ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:43:28.129664Z","caller":"traceutil/trace.go:171","msg":"trace[2095518184] transaction","detail":"{read_only:false; response_revision:2551; number_of_response:1; }","duration":"119.207097ms","start":"2026-06-26T03:43:28.010428Z","end":"2026-06-26T03:43:28.129636Z","steps":["trace[2095518184] 'process raft request' (duration: 118.994191ms)"],"step_count":1}