{"level":"warn","ts":"2026-06-09T01:10:37.254311Z","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-09T01:10:37.254382Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.116: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.204.45.116:2380","--initial-cluster=instance=https://199.204.45.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.116: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-09T01:10:37.254443Z","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-09T01:10:37.254452Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-06-09T01:10:37.254475Z","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-09T01:10:37.255098Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"]} {"level":"info","ts":"2026-06-09T01:10:37.255188Z","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.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.116: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-09T01:10:37.262823Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.419511ms"} {"level":"info","ts":"2026-06-09T01:10:37.268413Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5caa70ef1dd6dc04","cluster-id":"45afccab143d2c82"} {"level":"info","ts":"2026-06-09T01:10:37.2685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=()"} {"level":"info","ts":"2026-06-09T01:10:37.268524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 0"} {"level":"info","ts":"2026-06-09T01:10:37.268534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5caa70ef1dd6dc04 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-09T01:10:37.268546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 1"} {"level":"info","ts":"2026-06-09T01:10:37.268585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"warn","ts":"2026-06-09T01:10:37.273702Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-09T01:10:37.276188Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-09T01:10:37.277882Z","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-09T01:10:37.281176Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5caa70ef1dd6dc04","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-09T01:10:37.281683Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5caa70ef1dd6dc04","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-09T01:10:37.281718Z","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-09T01:10:37.281823Z","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-09T01:10:37.281835Z","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-09T01:10:37.282293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"info","ts":"2026-06-09T01:10:37.283748Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","added-peer-id":"5caa70ef1dd6dc04","added-peer-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-06-09T01:10:37.285955Z","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-09T01:10:37.286152Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5caa70ef1dd6dc04","initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-09T01:10:37.286182Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-09T01:10:37.286253Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-06-09T01:10:37.286266Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-06-09T01:10:37.469371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 is starting a new election at term 1"} {"level":"info","ts":"2026-06-09T01:10:37.469462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-09T01:10:37.469498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgPreVoteResp from 5caa70ef1dd6dc04 at term 1"} {"level":"info","ts":"2026-06-09T01:10:37.469518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became candidate at term 2"} {"level":"info","ts":"2026-06-09T01:10:37.469549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgVoteResp from 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-06-09T01:10:37.469577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became leader at term 2"} {"level":"info","ts":"2026-06-09T01:10:37.469595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5caa70ef1dd6dc04 elected leader 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-06-09T01:10:37.470447Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T01:10:37.470702Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5caa70ef1dd6dc04","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.116:2379]}","request-path":"/0/members/5caa70ef1dd6dc04/attributes","cluster-id":"45afccab143d2c82","publish-timeout":"7s"} {"level":"info","ts":"2026-06-09T01:10:37.470761Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T01:10:37.470992Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-09T01:10:37.471057Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-09T01:10:37.470738Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T01:10:37.471664Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T01:10:37.471735Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T01:10:37.471758Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T01:10:37.47279Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-09T01:10:37.472833Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.116:2379"} {"level":"info","ts":"2026-06-09T01:10:48.488195Z","caller":"traceutil/trace.go:171","msg":"trace[165080011] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"116.077124ms","start":"2026-06-09T01:10:48.372087Z","end":"2026-06-09T01:10:48.488164Z","steps":["trace[165080011] 'process raft request' (duration: 69.469028ms)","trace[165080011] 'compare' (duration: 46.105726ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:10:49.43181Z","caller":"traceutil/trace.go:171","msg":"trace[343252281] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"182.893683ms","start":"2026-06-09T01:10:49.24888Z","end":"2026-06-09T01:10:49.431773Z","steps":["trace[343252281] 'process raft request' (duration: 182.77017ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:10:49.432395Z","caller":"traceutil/trace.go:171","msg":"trace[82242708] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"119.592761ms","start":"2026-06-09T01:10:49.312794Z","end":"2026-06-09T01:10:49.432386Z","steps":["trace[82242708] 'process raft request' (duration: 119.5474ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:10:55.32689Z","caller":"traceutil/trace.go:171","msg":"trace[392809187] linearizableReadLoop","detail":"{readStateIndex:392; appliedIndex:391; }","duration":"442.099917ms","start":"2026-06-09T01:10:54.88476Z","end":"2026-06-09T01:10:55.32686Z","steps":["trace[392809187] 'read index received' (duration: 441.855712ms)","trace[392809187] 'applied index is now lower than readState.Index' (duration: 242.825µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:10:55.326998Z","caller":"traceutil/trace.go:171","msg":"trace[1762916922] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"471.894552ms","start":"2026-06-09T01:10:54.855073Z","end":"2026-06-09T01:10:55.326967Z","steps":["trace[1762916922] 'process raft request' (duration: 471.631647ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:10:55.327188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.444887ms","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-09T01:10:55.327221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.439223ms","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-09T01:10:55.32737Z","caller":"traceutil/trace.go:171","msg":"trace[187022636] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:376; }","duration":"190.683152ms","start":"2026-06-09T01:10:55.136667Z","end":"2026-06-09T01:10:55.32735Z","steps":["trace[187022636] 'agreement among raft nodes before linearized reading' (duration: 190.409997ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:10:55.327385Z","caller":"traceutil/trace.go:171","msg":"trace[1388486565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:376; }","duration":"442.656497ms","start":"2026-06-09T01:10:54.884709Z","end":"2026-06-09T01:10:55.327365Z","steps":["trace[1388486565] 'agreement among raft nodes before linearized reading' (duration: 442.313411ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:10:55.327431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:10:54.884688Z","time spent":"442.735128ms","remote":"127.0.0.1:47472","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-09T01:10:55.327663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:10:54.855029Z","time spent":"472.068845ms","remote":"127.0.0.1:47472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:10:56.870747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.329856776s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T01:10:56.871232Z","caller":"traceutil/trace.go:171","msg":"trace[903504583] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"1.539316155s","start":"2026-06-09T01:10:55.331852Z","end":"2026-06-09T01:10:56.871168Z","steps":["trace[903504583] 'process raft request' (duration: 208.840486ms)","trace[903504583] 'compare' (duration: 1.329737884s)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:10:56.87127Z","caller":"traceutil/trace.go:171","msg":"trace[243880153] linearizableReadLoop","detail":"{readStateIndex:394; appliedIndex:393; }","duration":"1.487726496s","start":"2026-06-09T01:10:55.383488Z","end":"2026-06-09T01:10:56.871215Z","steps":["trace[243880153] 'read index received' (duration: 157.095344ms)","trace[243880153] 'applied index is now lower than readState.Index' (duration: 1.330625652s)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:10:56.871472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:10:55.331839Z","time spent":"1.539499519s","remote":"127.0.0.1:47472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:10:57.062585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.67907595s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:10:57.062733Z","caller":"traceutil/trace.go:171","msg":"trace[1186005399] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:378; }","duration":"1.679266734s","start":"2026-06-09T01:10:55.383446Z","end":"2026-06-09T01:10:57.062712Z","steps":["trace[1186005399] 'agreement among raft nodes before linearized reading' (duration: 1.487877069s)","trace[1186005399] 'range keys from in-memory index tree' (duration: 191.199911ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:10:57.062911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:10:55.383431Z","time spent":"1.679460337s","remote":"127.0.0.1:47256","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-09T01:10:57.062722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.823302ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-09T01:10:57.063243Z","caller":"traceutil/trace.go:171","msg":"trace[1491438776] linearizableReadLoop","detail":"{readStateIndex:395; appliedIndex:394; }","duration":"191.788712ms","start":"2026-06-09T01:10:56.871437Z","end":"2026-06-09T01:10:57.063226Z","steps":["trace[1491438776] 'read index received' (duration: 63.431µs)","trace[1491438776] 'applied index is now lower than readState.Index' (duration: 191.723811ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:10:57.063344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.61273262s","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-09T01:10:57.063378Z","caller":"traceutil/trace.go:171","msg":"trace[1583345887] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:378; }","duration":"1.612803451s","start":"2026-06-09T01:10:55.450566Z","end":"2026-06-09T01:10:57.063369Z","steps":["trace[1583345887] 'agreement among raft nodes before linearized reading' (duration: 1.612725339s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:10:57.06341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:10:55.450548Z","time spent":"1.612854661s","remote":"127.0.0.1:47472","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-09T01:11:15.009791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.063045ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-09T01:11:15.010001Z","caller":"traceutil/trace.go:171","msg":"trace[333999715] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"234.448206ms","start":"2026-06-09T01:11:14.775518Z","end":"2026-06-09T01:11:15.009967Z","steps":["trace[333999715] 'process raft request' (duration: 133.151928ms)","trace[333999715] 'compare' (duration: 100.936352ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:11:15.010019Z","caller":"traceutil/trace.go:171","msg":"trace[1549589256] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"233.692934ms","start":"2026-06-09T01:11:14.776306Z","end":"2026-06-09T01:11:15.009999Z","steps":["trace[1549589256] 'process raft request' (duration: 233.576802ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:11:17.473153Z","caller":"traceutil/trace.go:171","msg":"trace[762559882] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"618.70942ms","start":"2026-06-09T01:11:16.85442Z","end":"2026-06-09T01:11:17.473129Z","steps":["trace[762559882] 'process raft request' (duration: 618.561227ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:17.473358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:16.854401Z","time spent":"618.897092ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:11:17.522777Z","caller":"traceutil/trace.go:171","msg":"trace[1161592347] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"656.2722ms","start":"2026-06-09T01:11:16.866479Z","end":"2026-06-09T01:11:17.522751Z","steps":["trace[1161592347] 'process raft request' (duration: 656.211059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:17.522927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:16.866468Z","time spent":"656.396412ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:11:17.523089Z","caller":"traceutil/trace.go:171","msg":"trace[1057486926] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"668.515849ms","start":"2026-06-09T01:11:16.854477Z","end":"2026-06-09T01:11:17.522993Z","steps":["trace[1057486926] 'process raft request' (duration: 668.012449ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:11:17.523269Z","caller":"traceutil/trace.go:171","msg":"trace[1978557648] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"660.612518ms","start":"2026-06-09T01:11:16.862621Z","end":"2026-06-09T01:11:17.523233Z","steps":["trace[1978557648] 'process raft request' (duration: 660.021298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:17.523325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:16.854457Z","time spent":"668.726612ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:11:17.523512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:16.862605Z","time spent":"660.841472ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:11:17.523797Z","caller":"traceutil/trace.go:171","msg":"trace[93319929] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"657.241247ms","start":"2026-06-09T01:11:16.866542Z","end":"2026-06-09T01:11:17.523783Z","steps":["trace[93319929] 'process raft request' (duration: 656.29016ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:11:17.523838Z","caller":"traceutil/trace.go:171","msg":"trace[1901485180] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"664.71946ms","start":"2026-06-09T01:11:16.859087Z","end":"2026-06-09T01:11:17.523806Z","steps":["trace[1901485180] 'process raft request' (duration: 663.514169ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:17.523932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:16.866538Z","time spent":"657.333148ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:11:17.52395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:16.859067Z","time spent":"664.827203ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:11:17.524097Z","caller":"traceutil/trace.go:171","msg":"trace[1072213311] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"657.501512ms","start":"2026-06-09T01:11:16.866584Z","end":"2026-06-09T01:11:17.524086Z","steps":["trace[1072213311] 'process raft request' (duration: 657.128024ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:11:17.524147Z","caller":"traceutil/trace.go:171","msg":"trace[120840873] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"651.253161ms","start":"2026-06-09T01:11:16.872875Z","end":"2026-06-09T01:11:17.524128Z","steps":["trace[120840873] 'process raft request' (duration: 650.908814ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:17.524216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:16.866566Z","time spent":"657.593384ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:11:17.524276Z","caller":"traceutil/trace.go:171","msg":"trace[2001702597] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"647.079836ms","start":"2026-06-09T01:11:16.877185Z","end":"2026-06-09T01:11:17.524264Z","steps":["trace[2001702597] 'process raft request' (duration: 646.647527ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:17.524327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:16.877164Z","time spent":"647.141247ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:11:17.524226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:16.872864Z","time spent":"651.330973ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:11:17.524447Z","caller":"traceutil/trace.go:171","msg":"trace[880646293] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"640.934407ms","start":"2026-06-09T01:11:16.883493Z","end":"2026-06-09T01:11:17.524428Z","steps":["trace[880646293] 'process raft request' (duration: 640.459779ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:17.524535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:16.883478Z","time spent":"641.022068ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:11:17.524575Z","caller":"traceutil/trace.go:171","msg":"trace[1952968623] linearizableReadLoop","detail":"{readStateIndex:521; appliedIndex:510; }","duration":"477.439706ms","start":"2026-06-09T01:11:17.047117Z","end":"2026-06-09T01:11:17.524557Z","steps":["trace[1952968623] 'read index received' (duration: 426.350173ms)","trace[1952968623] 'applied index is now lower than readState.Index' (duration: 51.088443ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:11:17.52464Z","caller":"traceutil/trace.go:171","msg":"trace[1532363552] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"627.037768ms","start":"2026-06-09T01:11:16.89759Z","end":"2026-06-09T01:11:17.524628Z","steps":["trace[1532363552] 'process raft request' (duration: 626.608381ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:11:17.524679Z","caller":"traceutil/trace.go:171","msg":"trace[1578606332] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"497.149358ms","start":"2026-06-09T01:11:17.027492Z","end":"2026-06-09T01:11:17.524641Z","steps":["trace[1578606332] 'process raft request' (duration: 496.930315ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:17.52473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:16.897569Z","time spent":"627.128159ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T01:11:17.524808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.684411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-09T01:11:17.524851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:17.027461Z","time spent":"497.311241ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:11:17.524881Z","caller":"traceutil/trace.go:171","msg":"trace[1182195260] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:500; }","duration":"477.764102ms","start":"2026-06-09T01:11:17.047103Z","end":"2026-06-09T01:11:17.524867Z","steps":["trace[1182195260] 'agreement among raft nodes before linearized reading' (duration: 477.595939ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:17.524946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:17.047059Z","time spent":"477.876043ms","remote":"127.0.0.1:47472","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-09T01:11:17.529566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.471006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:11:17.529623Z","caller":"traceutil/trace.go:171","msg":"trace[31503569] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:502; }","duration":"146.559878ms","start":"2026-06-09T01:11:17.383048Z","end":"2026-06-09T01:11:17.529608Z","steps":["trace[31503569] 'agreement among raft nodes before linearized reading' (duration: 146.489816ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:17.530041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.022668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-09T01:11:17.530168Z","caller":"traceutil/trace.go:171","msg":"trace[1585763318] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:502; }","duration":"202.185591ms","start":"2026-06-09T01:11:17.327966Z","end":"2026-06-09T01:11:17.530152Z","steps":["trace[1585763318] 'agreement among raft nodes before linearized reading' (duration: 201.189413ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:20.164191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.042616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:11:20.164324Z","caller":"traceutil/trace.go:171","msg":"trace[1373041302] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:0; response_revision:572; }","duration":"133.223639ms","start":"2026-06-09T01:11:20.031059Z","end":"2026-06-09T01:11:20.164283Z","steps":["trace[1373041302] 'range keys from in-memory index tree' (duration: 132.907553ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:11:23.907567Z","caller":"traceutil/trace.go:171","msg":"trace[53039688] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"297.375622ms","start":"2026-06-09T01:11:23.610154Z","end":"2026-06-09T01:11:23.907529Z","steps":["trace[53039688] 'process raft request' (duration: 259.841011ms)","trace[53039688] 'compare' (duration: 37.405798ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:11:23.92618Z","caller":"traceutil/trace.go:171","msg":"trace[1649935875] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"315.892452ms","start":"2026-06-09T01:11:23.610261Z","end":"2026-06-09T01:11:23.926153Z","steps":["trace[1649935875] 'process raft request' (duration: 315.703479ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:23.926342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:23.610239Z","time spent":"316.024784ms","remote":"127.0.0.1:47472","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-09T01:11:23.926534Z","caller":"traceutil/trace.go:171","msg":"trace[942659451] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"316.284349ms","start":"2026-06-09T01:11:23.610221Z","end":"2026-06-09T01:11:23.926505Z","steps":["trace[942659451] 'process raft request' (duration: 316.148767ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:11:23.926573Z","caller":"traceutil/trace.go:171","msg":"trace[1381932061] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"275.388087ms","start":"2026-06-09T01:11:23.651159Z","end":"2026-06-09T01:11:23.926547Z","steps":["trace[1381932061] 'process raft request' (duration: 275.291305ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:11:23.926609Z","caller":"traceutil/trace.go:171","msg":"trace[1471450185] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"316.268808ms","start":"2026-06-09T01:11:23.610329Z","end":"2026-06-09T01:11:23.926598Z","steps":["trace[1471450185] 'process raft request' (duration: 315.783339ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:23.926666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:23.610302Z","time spent":"316.334469ms","remote":"127.0.0.1:47472","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-09T01:11:23.92656Z","caller":"traceutil/trace.go:171","msg":"trace[1538479007] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:621; }","duration":"253.929924ms","start":"2026-06-09T01:11:23.672599Z","end":"2026-06-09T01:11:23.926529Z","steps":["trace[1538479007] 'read index received' (duration: 197.585289ms)","trace[1538479007] 'applied index is now lower than readState.Index' (duration: 56.343885ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:11:23.926705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:23.61021Z","time spent":"316.405421ms","remote":"127.0.0.1:47472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:11:23.926825Z","caller":"traceutil/trace.go:171","msg":"trace[1660181219] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"201.230094ms","start":"2026-06-09T01:11:23.725581Z","end":"2026-06-09T01:11:23.926812Z","steps":["trace[1660181219] 'process raft request' (duration: 200.907958ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:23.926867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.256341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xl9vc\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-09T01:11:23.926978Z","caller":"traceutil/trace.go:171","msg":"trace[870930096] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xl9vc; range_end:; response_count:1; response_revision:601; }","duration":"254.358422ms","start":"2026-06-09T01:11:23.672585Z","end":"2026-06-09T01:11:23.926943Z","steps":["trace[870930096] 'agreement among raft nodes before linearized reading' (duration: 254.023546ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:11:24.78408Z","caller":"traceutil/trace.go:171","msg":"trace[352252585] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"841.155962ms","start":"2026-06-09T01:11:23.942894Z","end":"2026-06-09T01:11:24.78405Z","steps":["trace[352252585] 'process raft request' (duration: 840.962029ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:24.784265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:23.94288Z","time spent":"841.284084ms","remote":"127.0.0.1:47398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:11:24.856371Z","caller":"traceutil/trace.go:171","msg":"trace[1524833093] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:627; }","duration":"473.411854ms","start":"2026-06-09T01:11:24.382932Z","end":"2026-06-09T01:11:24.856344Z","steps":["trace[1524833093] 'read index received' (duration: 400.860819ms)","trace[1524833093] 'applied index is now lower than readState.Index' (duration: 72.549885ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:11:24.856436Z","caller":"traceutil/trace.go:171","msg":"trace[650030234] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"513.237785ms","start":"2026-06-09T01:11:24.34315Z","end":"2026-06-09T01:11:24.856387Z","steps":["trace[650030234] 'process raft request' (duration: 512.736597ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:24.856506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.561498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:11:24.856541Z","caller":"traceutil/trace.go:171","msg":"trace[1296644856] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"473.64674ms","start":"2026-06-09T01:11:24.382883Z","end":"2026-06-09T01:11:24.85653Z","steps":["trace[1296644856] 'agreement among raft nodes before linearized reading' (duration: 473.554298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:24.856583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:24.382866Z","time spent":"473.70878ms","remote":"127.0.0.1:47256","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-09T01:11:24.856836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:24.343118Z","time spent":"513.392169ms","remote":"127.0.0.1:47336","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:11:26.412967Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853971040938219839,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T01:11:26.72114Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.810886939s","expected-duration":"1s"} {"level":"info","ts":"2026-06-09T01:11:26.721537Z","caller":"traceutil/trace.go:171","msg":"trace[2105011388] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"1.8114251s","start":"2026-06-09T01:11:24.910091Z","end":"2026-06-09T01:11:26.721517Z","steps":["trace[2105011388] 'process raft request' (duration: 1.811278826s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:26.72168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:24.910066Z","time spent":"1.811557251s","remote":"127.0.0.1:47442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T01:11:26.741055Z","caller":"traceutil/trace.go:171","msg":"trace[1102663540] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:629; }","duration":"829.065167ms","start":"2026-06-09T01:11:25.911962Z","end":"2026-06-09T01:11:26.741027Z","steps":["trace[1102663540] 'read index received' (duration: 809.454917ms)","trace[1102663540] 'applied index is now lower than readState.Index' (duration: 19.60876ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:11:26.741486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.499674ms","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-09T01:11:26.741561Z","caller":"traceutil/trace.go:171","msg":"trace[1675956549] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:604; }","duration":"829.623056ms","start":"2026-06-09T01:11:25.91192Z","end":"2026-06-09T01:11:26.741543Z","steps":["trace[1675956549] 'agreement among raft nodes before linearized reading' (duration: 829.27954ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:26.741603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:25.911901Z","time spent":"829.691808ms","remote":"127.0.0.1:47472","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-09T01:11:26.741705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.734067ms","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-09T01:11:26.74176Z","caller":"traceutil/trace.go:171","msg":"trace[1216359646] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:604; }","duration":"810.87778ms","start":"2026-06-09T01:11:25.930868Z","end":"2026-06-09T01:11:26.741746Z","steps":["trace[1216359646] 'agreement among raft nodes before linearized reading' (duration: 810.499844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:26.741842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.013981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:11:26.7419Z","caller":"traceutil/trace.go:171","msg":"trace[1827368960] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"359.108883ms","start":"2026-06-09T01:11:26.382776Z","end":"2026-06-09T01:11:26.741885Z","steps":["trace[1827368960] 'agreement among raft nodes before linearized reading' (duration: 358.980011ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:26.741942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:26.382753Z","time spent":"359.181934ms","remote":"127.0.0.1:47256","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-09T01:11:26.741889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:25.930852Z","time spent":"811.024363ms","remote":"127.0.0.1:47472","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-09T01:11:26.742292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.82548ms","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-09T01:11:26.742329Z","caller":"traceutil/trace.go:171","msg":"trace[1942675254] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:604; }","duration":"810.87978ms","start":"2026-06-09T01:11:25.93144Z","end":"2026-06-09T01:11:26.742319Z","steps":["trace[1942675254] 'agreement among raft nodes before linearized reading' (duration: 810.740128ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:26.742358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:25.931433Z","time spent":"810.918521ms","remote":"127.0.0.1:47472","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-09T01:11:26.742896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.949472ms","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-09T01:11:26.742979Z","caller":"traceutil/trace.go:171","msg":"trace[1407680909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:604; }","duration":"811.057283ms","start":"2026-06-09T01:11:25.9319Z","end":"2026-06-09T01:11:26.742957Z","steps":["trace[1407680909] 'agreement among raft nodes before linearized reading' (duration: 810.061025ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:26.743068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:25.93189Z","time spent":"811.169306ms","remote":"127.0.0.1:47472","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-09T01:11:31.881032Z","caller":"traceutil/trace.go:171","msg":"trace[1689116292] linearizableReadLoop","detail":"{readStateIndex:711; appliedIndex:710; }","duration":"124.138257ms","start":"2026-06-09T01:11:31.756872Z","end":"2026-06-09T01:11:31.88101Z","steps":["trace[1689116292] 'read index received' (duration: 115.091745ms)","trace[1689116292] 'applied index is now lower than readState.Index' (duration: 9.045762ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:11:31.881119Z","caller":"traceutil/trace.go:171","msg":"trace[619540924] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"125.015964ms","start":"2026-06-09T01:11:31.756069Z","end":"2026-06-09T01:11:31.881085Z","steps":["trace[619540924] 'process raft request' (duration: 115.991052ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:31.881213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.32014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-06-09T01:11:31.881253Z","caller":"traceutil/trace.go:171","msg":"trace[925485280] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:683; }","duration":"124.394982ms","start":"2026-06-09T01:11:31.756849Z","end":"2026-06-09T01:11:31.881244Z","steps":["trace[925485280] 'agreement among raft nodes before linearized reading' (duration: 124.24805ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:11:42.975412Z","caller":"traceutil/trace.go:171","msg":"trace[668959223] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"134.336679ms","start":"2026-06-09T01:11:42.841055Z","end":"2026-06-09T01:11:42.975392Z","steps":["trace[668959223] 'process raft request' (duration: 134.254307ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:11:42.975594Z","caller":"traceutil/trace.go:171","msg":"trace[1943702663] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"136.015579ms","start":"2026-06-09T01:11:42.839392Z","end":"2026-06-09T01:11:42.975408Z","steps":["trace[1943702663] 'process raft request' (duration: 108.815944ms)","trace[1943702663] 'compare' (duration: 27.013602ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:11:42.975695Z","caller":"traceutil/trace.go:171","msg":"trace[437666680] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"132.736931ms","start":"2026-06-09T01:11:42.842948Z","end":"2026-06-09T01:11:42.975685Z","steps":["trace[437666680] 'process raft request' (duration: 132.396654ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:11:43.116353Z","caller":"traceutil/trace.go:171","msg":"trace[421984343] linearizableReadLoop","detail":"{readStateIndex:798; appliedIndex:797; }","duration":"128.028536ms","start":"2026-06-09T01:11:42.9883Z","end":"2026-06-09T01:11:43.116328Z","steps":["trace[421984343] 'read index received' (duration: 95.723609ms)","trace[421984343] 'applied index is now lower than readState.Index' (duration: 32.303977ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:11:43.116543Z","caller":"traceutil/trace.go:171","msg":"trace[1219644027] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"136.880135ms","start":"2026-06-09T01:11:42.979622Z","end":"2026-06-09T01:11:43.116502Z","steps":["trace[1219644027] 'process raft request' (duration: 104.493187ms)","trace[1219644027] 'compare' (duration: 32.059812ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:11:43.116687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.27334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:11:43.116797Z","caller":"traceutil/trace.go:171","msg":"trace[8251207] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:767; }","duration":"128.511794ms","start":"2026-06-09T01:11:42.988266Z","end":"2026-06-09T01:11:43.116778Z","steps":["trace[8251207] 'agreement among raft nodes before linearized reading' (duration: 128.249069ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:11:44.233235Z","caller":"traceutil/trace.go:171","msg":"trace[159329858] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"391.292918ms","start":"2026-06-09T01:11:43.841917Z","end":"2026-06-09T01:11:44.23321Z","steps":["trace[159329858] 'process raft request' (duration: 391.128205ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:44.233414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:43.841893Z","time spent":"391.428251ms","remote":"127.0.0.1:47442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:11:44.245434Z","caller":"traceutil/trace.go:171","msg":"trace[393686671] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"361.869282ms","start":"2026-06-09T01:11:43.883541Z","end":"2026-06-09T01:11:44.24541Z","steps":["trace[393686671] 'process raft request' (duration: 361.75666ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:11:44.245607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:11:43.883513Z","time spent":"362.004435ms","remote":"127.0.0.1:47390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5052,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:11:58.417657Z","caller":"traceutil/trace.go:171","msg":"trace[673457916] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"188.325894ms","start":"2026-06-09T01:11:58.229278Z","end":"2026-06-09T01:11:58.417604Z","steps":["trace[673457916] 'process raft request' (duration: 112.086611ms)","trace[673457916] 'compare' (duration: 76.063479ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:11:58.424018Z","caller":"traceutil/trace.go:171","msg":"trace[1695840409] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"194.252949ms","start":"2026-06-09T01:11:58.229755Z","end":"2026-06-09T01:11:58.424008Z","steps":["trace[1695840409] 'process raft request' (duration: 194.125057ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:11:58.424108Z","caller":"traceutil/trace.go:171","msg":"trace[2032238927] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"192.091ms","start":"2026-06-09T01:11:58.231988Z","end":"2026-06-09T01:11:58.424079Z","steps":["trace[2032238927] 'process raft request' (duration: 191.953908ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:11:58.424217Z","caller":"traceutil/trace.go:171","msg":"trace[272513239] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"188.942304ms","start":"2026-06-09T01:11:58.235257Z","end":"2026-06-09T01:11:58.424199Z","steps":["trace[272513239] 'process raft request' (duration: 188.719471ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:12:17.398858Z","caller":"traceutil/trace.go:171","msg":"trace[1457801410] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"135.623071ms","start":"2026-06-09T01:12:17.263212Z","end":"2026-06-09T01:12:17.398835Z","steps":["trace[1457801410] 'process raft request' (duration: 135.341166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:19.744811Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853971040938220660,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T01:12:20.039388Z","caller":"traceutil/trace.go:171","msg":"trace[592317617] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"870.852912ms","start":"2026-06-09T01:12:19.168516Z","end":"2026-06-09T01:12:20.039369Z","steps":["trace[592317617] 'process raft request' (duration: 870.70672ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:20.0395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:19.168485Z","time spent":"870.958785ms","remote":"127.0.0.1:47472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:12:20.621568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.115532ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T01:12:20.621655Z","caller":"traceutil/trace.go:171","msg":"trace[1333783240] linearizableReadLoop","detail":"{readStateIndex:1027; appliedIndex:1025; }","duration":"1.377730628s","start":"2026-06-09T01:12:19.243902Z","end":"2026-06-09T01:12:20.621633Z","steps":["trace[1333783240] 'read index received' (duration: 795.397312ms)","trace[1333783240] 'applied index is now lower than readState.Index' (duration: 582.332456ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:12:20.621737Z","caller":"traceutil/trace.go:171","msg":"trace[430174004] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"1.406536506s","start":"2026-06-09T01:12:19.215177Z","end":"2026-06-09T01:12:20.621713Z","steps":["trace[430174004] 'process raft request' (duration: 980.20865ms)","trace[430174004] 'compare' (duration: 426.029311ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:12:20.621779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:19.215153Z","time spent":"1.406604577s","remote":"127.0.0.1:47472","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-09T01:12:20.621948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.378055385s","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-09T01:12:20.621975Z","caller":"traceutil/trace.go:171","msg":"trace[240626807] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:986; }","duration":"1.378118265s","start":"2026-06-09T01:12:19.243848Z","end":"2026-06-09T01:12:20.621966Z","steps":["trace[240626807] 'agreement among raft nodes before linearized reading' (duration: 1.378018503s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:20.622001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:19.243827Z","time spent":"1.378168497s","remote":"127.0.0.1:47472","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-09T01:12:20.622137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.624911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T01:12:20.62216Z","caller":"traceutil/trace.go:171","msg":"trace[561003986] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:986; }","duration":"540.680481ms","start":"2026-06-09T01:12:20.081472Z","end":"2026-06-09T01:12:20.622153Z","steps":["trace[561003986] 'agreement among raft nodes before linearized reading' (duration: 540.637541ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:20.622188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:20.081455Z","time spent":"540.727173ms","remote":"127.0.0.1:47388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":29,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-06-09T01:12:20.622178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.321917065s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-06-09T01:12:20.622222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.708811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T01:12:20.622297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.240278406s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T01:12:20.622278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.220206041s","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-09T01:12:20.622301Z","caller":"traceutil/trace.go:171","msg":"trace[729088139] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:986; }","duration":"224.829043ms","start":"2026-06-09T01:12:20.397454Z","end":"2026-06-09T01:12:20.622283Z","steps":["trace[729088139] 'agreement among raft nodes before linearized reading' (duration: 224.71145ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:12:20.622328Z","caller":"traceutil/trace.go:171","msg":"trace[938754254] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:986; }","duration":"1.240321727s","start":"2026-06-09T01:12:19.381997Z","end":"2026-06-09T01:12:20.622319Z","steps":["trace[938754254] 'agreement among raft nodes before linearized reading' (duration: 1.240278466s)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:12:20.622358Z","caller":"traceutil/trace.go:171","msg":"trace[686414875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:986; }","duration":"1.220310184s","start":"2026-06-09T01:12:19.402026Z","end":"2026-06-09T01:12:20.622336Z","steps":["trace[686414875] 'agreement among raft nodes before linearized reading' (duration: 1.22009766s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:20.622362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:19.381989Z","time spent":"1.240365528s","remote":"127.0.0.1:47256","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-09T01:12:20.622397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:19.402012Z","time spent":"1.220377045s","remote":"127.0.0.1:47472","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-09T01:12:20.622247Z","caller":"traceutil/trace.go:171","msg":"trace[1090590949] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:986; }","duration":"1.322023317s","start":"2026-06-09T01:12:19.300206Z","end":"2026-06-09T01:12:20.622229Z","steps":["trace[1090590949] 'agreement among raft nodes before linearized reading' (duration: 1.321785723s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:20.622471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:19.300192Z","time spent":"1.322250791s","remote":"127.0.0.1:47472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-09T01:12:21.283528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.665711ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T01:12:21.283682Z","caller":"traceutil/trace.go:171","msg":"trace[1551563374] transaction","detail":"{read_only:false; response_revision:987; number_of_response:1; }","duration":"657.684124ms","start":"2026-06-09T01:12:20.625958Z","end":"2026-06-09T01:12:21.283642Z","steps":["trace[1551563374] 'process raft request' (duration: 183.780719ms)","trace[1551563374] 'compare' (duration: 473.370865ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:12:21.283772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:20.625946Z","time spent":"657.788357ms","remote":"127.0.0.1:47472","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-09T01:12:21.810309Z","caller":"traceutil/trace.go:171","msg":"trace[927864997] linearizableReadLoop","detail":"{readStateIndex:1030; appliedIndex:1027; }","duration":"1.181150003s","start":"2026-06-09T01:12:20.629138Z","end":"2026-06-09T01:12:21.810288Z","steps":["trace[927864997] 'read index received' (duration: 180.678525ms)","trace[927864997] 'applied index is now lower than readState.Index' (duration: 1.000470708s)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:12:21.810505Z","caller":"traceutil/trace.go:171","msg":"trace[953197802] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"1.18325003s","start":"2026-06-09T01:12:20.627222Z","end":"2026-06-09T01:12:21.810472Z","steps":["trace[953197802] 'process raft request' (duration: 1.183025006s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:21.810594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.181443889s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:12:21.810659Z","caller":"traceutil/trace.go:171","msg":"trace[67842748] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:989; }","duration":"1.18153737s","start":"2026-06-09T01:12:20.629109Z","end":"2026-06-09T01:12:21.810646Z","steps":["trace[67842748] 'agreement among raft nodes before linearized reading' (duration: 1.181421318s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:21.810658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:20.6272Z","time spent":"1.183392262s","remote":"127.0.0.1:47472","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-09T01:12:21.81069Z","caller":"traceutil/trace.go:171","msg":"trace[1812414347] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"1.184548563s","start":"2026-06-09T01:12:20.626129Z","end":"2026-06-09T01:12:21.810678Z","steps":["trace[1812414347] 'process raft request' (duration: 1.136242911s)","trace[1812414347] 'compare' (duration: 47.682361ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:12:21.810698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:20.6291Z","time spent":"1.181591131s","remote":"127.0.0.1:47256","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-09T01:12:21.810792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:20.626106Z","time spent":"1.184617804s","remote":"127.0.0.1:47472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:12:21.815391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.109999219s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-09T01:12:21.815467Z","caller":"traceutil/trace.go:171","msg":"trace[1686162920] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:990; }","duration":"1.11010436s","start":"2026-06-09T01:12:20.705345Z","end":"2026-06-09T01:12:21.815449Z","steps":["trace[1686162920] 'agreement among raft nodes before linearized reading' (duration: 1.109929927s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:21.815475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.074809789s","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-09T01:12:21.815504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:20.705327Z","time spent":"1.110169752s","remote":"127.0.0.1:47282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.116\" "} {"level":"info","ts":"2026-06-09T01:12:21.815545Z","caller":"traceutil/trace.go:171","msg":"trace[690231447] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:990; }","duration":"1.074939981s","start":"2026-06-09T01:12:20.740589Z","end":"2026-06-09T01:12:21.815529Z","steps":["trace[690231447] 'agreement among raft nodes before linearized reading' (duration: 1.074673266s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:21.815606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:20.740565Z","time spent":"1.075033093s","remote":"127.0.0.1:47472","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-09T01:12:21.816389Z","caller":"traceutil/trace.go:171","msg":"trace[1837371079] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"803.75027ms","start":"2026-06-09T01:12:21.012621Z","end":"2026-06-09T01:12:21.816372Z","steps":["trace[1837371079] 'process raft request' (duration: 802.503748ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:21.816506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:21.012599Z","time spent":"803.851081ms","remote":"127.0.0.1:47472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:12:22.761679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.817464ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:12:22.761794Z","caller":"traceutil/trace.go:171","msg":"trace[628422182] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:990; }","duration":"595.944747ms","start":"2026-06-09T01:12:22.165833Z","end":"2026-06-09T01:12:22.761778Z","steps":["trace[628422182] 'range keys from in-memory index tree' (duration: 595.802484ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:22.761916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.206476ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"warn","ts":"2026-06-09T01:12:22.762077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:21.817055Z","time spent":"945.01866ms","remote":"127.0.0.1:47282","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-09T01:12:22.762121Z","caller":"traceutil/trace.go:171","msg":"trace[1001196006] linearizableReadLoop","detail":"{readStateIndex:1033; appliedIndex:1031; }","duration":"939.471042ms","start":"2026-06-09T01:12:21.822634Z","end":"2026-06-09T01:12:22.762105Z","steps":["trace[1001196006] 'read index received' (duration: 476.085243ms)","trace[1001196006] 'applied index is now lower than readState.Index' (duration: 463.384719ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:12:22.762188Z","caller":"traceutil/trace.go:171","msg":"trace[1225054425] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"942.512806ms","start":"2026-06-09T01:12:21.819667Z","end":"2026-06-09T01:12:22.762179Z","steps":["trace[1225054425] 'process raft request' (duration: 942.344723ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:22.76227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:21.819655Z","time spent":"942.556336ms","remote":"127.0.0.1:47472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:12:22.76236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.702546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:12:22.763098Z","caller":"traceutil/trace.go:171","msg":"trace[482629706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:991; }","duration":"940.451689ms","start":"2026-06-09T01:12:21.822616Z","end":"2026-06-09T01:12:22.763068Z","steps":["trace[482629706] 'agreement among raft nodes before linearized reading' (duration: 939.654655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:22.763209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:21.822609Z","time spent":"940.553891ms","remote":"127.0.0.1:47256","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-09T01:12:22.771256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.709659ms","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-09T01:12:22.771259Z","caller":"traceutil/trace.go:171","msg":"trace[1673616493] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"144.432587ms","start":"2026-06-09T01:12:22.6268Z","end":"2026-06-09T01:12:22.771232Z","steps":["trace[1673616493] 'process raft request' (duration: 144.220433ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:12:22.771298Z","caller":"traceutil/trace.go:171","msg":"trace[340533671] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:992; }","duration":"727.78831ms","start":"2026-06-09T01:12:22.043499Z","end":"2026-06-09T01:12:22.771288Z","steps":["trace[340533671] 'agreement among raft nodes before linearized reading' (duration: 727.647397ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:22.771501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:22.043484Z","time spent":"728.000594ms","remote":"127.0.0.1:47472","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":"info","ts":"2026-06-09T01:12:35.039264Z","caller":"traceutil/trace.go:171","msg":"trace[238074526] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"117.473481ms","start":"2026-06-09T01:12:34.921762Z","end":"2026-06-09T01:12:35.039235Z","steps":["trace[238074526] 'process raft request' (duration: 29.325717ms)","trace[238074526] 'compare' (duration: 88.027802ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:12:43.389091Z","caller":"traceutil/trace.go:171","msg":"trace[1091400949] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"505.842197ms","start":"2026-06-09T01:12:42.883226Z","end":"2026-06-09T01:12:43.389068Z","steps":["trace[1091400949] 'process raft request' (duration: 505.664304ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:43.389293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:42.883201Z","time spent":"505.96302ms","remote":"127.0.0.1:47472","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-09T01:12:43.941844Z","caller":"traceutil/trace.go:171","msg":"trace[919402271] linearizableReadLoop","detail":"{readStateIndex:1105; appliedIndex:1103; }","duration":"871.82508ms","start":"2026-06-09T01:12:43.069995Z","end":"2026-06-09T01:12:43.94182Z","steps":["trace[919402271] 'read index received' (duration: 318.904322ms)","trace[919402271] 'applied index is now lower than readState.Index' (duration: 552.919878ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:12:43.942302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.910336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:12:43.942413Z","caller":"traceutil/trace.go:171","msg":"trace[1494678132] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1059; }","duration":"583.073029ms","start":"2026-06-09T01:12:43.35932Z","end":"2026-06-09T01:12:43.942393Z","steps":["trace[1494678132] 'agreement among raft nodes before linearized reading' (duration: 582.898086ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:12:43.942465Z","caller":"traceutil/trace.go:171","msg":"trace[1408230993] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"972.117068ms","start":"2026-06-09T01:12:42.970335Z","end":"2026-06-09T01:12:43.942452Z","steps":["trace[1408230993] 'process raft request' (duration: 971.308434ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:43.942502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:43.359288Z","time spent":"583.198531ms","remote":"127.0.0.1:37520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-06-09T01:12:43.94258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.234667ms","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-09T01:12:43.942611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:42.97031Z","time spent":"972.217319ms","remote":"127.0.0.1:47472","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-09T01:12:43.942706Z","caller":"traceutil/trace.go:171","msg":"trace[1074723534] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1059; }","duration":"395.38676ms","start":"2026-06-09T01:12:43.547266Z","end":"2026-06-09T01:12:43.942653Z","steps":["trace[1074723534] 'agreement among raft nodes before linearized reading' (duration: 395.112916ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:43.942765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:43.547189Z","time spent":"395.567013ms","remote":"127.0.0.1:47472","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-09T01:12:43.942789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.673355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T01:12:43.942419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"872.39313ms","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-09T01:12:43.942852Z","caller":"traceutil/trace.go:171","msg":"trace[363800911] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1059; }","duration":"559.766817ms","start":"2026-06-09T01:12:43.383074Z","end":"2026-06-09T01:12:43.942841Z","steps":["trace[363800911] 'agreement among raft nodes before linearized reading' (duration: 559.689026ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:43.942892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:43.383028Z","time spent":"559.85559ms","remote":"127.0.0.1:47256","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-09T01:12:43.942925Z","caller":"traceutil/trace.go:171","msg":"trace[2074103346] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1059; }","duration":"872.944629ms","start":"2026-06-09T01:12:43.06995Z","end":"2026-06-09T01:12:43.942895Z","steps":["trace[2074103346] 'agreement among raft nodes before linearized reading' (duration: 872.317488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:43.943021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:43.069931Z","time spent":"873.061612ms","remote":"127.0.0.1:47472","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-09T01:12:44.260226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.186199ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T01:12:44.260356Z","caller":"traceutil/trace.go:171","msg":"trace[774965252] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"313.274233ms","start":"2026-06-09T01:12:43.947056Z","end":"2026-06-09T01:12:44.26033Z","steps":["trace[774965252] 'process raft request' (duration: 120.887912ms)","trace[774965252] 'compare' (duration: 191.994135ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:12:44.260423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:43.947019Z","time spent":"313.372195ms","remote":"127.0.0.1:47472","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-09T01:12:44.262138Z","caller":"traceutil/trace.go:171","msg":"trace[1612758369] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"315.053294ms","start":"2026-06-09T01:12:43.947073Z","end":"2026-06-09T01:12:44.262126Z","steps":["trace[1612758369] 'process raft request' (duration: 314.87664ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:44.262294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:43.947023Z","time spent":"315.181188ms","remote":"127.0.0.1:47472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:12:44.262311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.198451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-09T01:12:44.262404Z","caller":"traceutil/trace.go:171","msg":"trace[1798199712] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1061; }","duration":"233.326304ms","start":"2026-06-09T01:12:44.029058Z","end":"2026-06-09T01:12:44.262384Z","steps":["trace[1798199712] 'agreement among raft nodes before linearized reading' (duration: 233.165151ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:12:44.262089Z","caller":"traceutil/trace.go:171","msg":"trace[1261184318] linearizableReadLoop","detail":"{readStateIndex:1107; appliedIndex:1105; }","duration":"232.912636ms","start":"2026-06-09T01:12:44.029118Z","end":"2026-06-09T01:12:44.26203Z","steps":["trace[1261184318] 'read index received' (duration: 38.821935ms)","trace[1261184318] 'applied index is now lower than readState.Index' (duration: 194.089831ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:12:44.262793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.040319ms","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-09T01:12:44.262858Z","caller":"traceutil/trace.go:171","msg":"trace[415140932] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1061; }","duration":"203.141291ms","start":"2026-06-09T01:12:44.059698Z","end":"2026-06-09T01:12:44.262839Z","steps":["trace[415140932] 'agreement among raft nodes before linearized reading' (duration: 202.991279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:45.07298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.310421ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T01:12:45.073053Z","caller":"traceutil/trace.go:171","msg":"trace[1067066234] linearizableReadLoop","detail":"{readStateIndex:1109; appliedIndex:1108; }","duration":"689.567248ms","start":"2026-06-09T01:12:44.383473Z","end":"2026-06-09T01:12:45.07304Z","steps":["trace[1067066234] 'read index received' (duration: 12.073733ms)","trace[1067066234] 'applied index is now lower than readState.Index' (duration: 677.492395ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:12:45.07311Z","caller":"traceutil/trace.go:171","msg":"trace[1240438015] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"806.431978ms","start":"2026-06-09T01:12:44.26667Z","end":"2026-06-09T01:12:45.073102Z","steps":["trace[1240438015] 'process raft request' (duration: 128.926773ms)","trace[1240438015] 'compare' (duration: 676.979935ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:12:45.073148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:44.266645Z","time spent":"806.482378ms","remote":"127.0.0.1:47472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:12:45.073251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.332064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T01:12:45.073322Z","caller":"traceutil/trace.go:171","msg":"trace[1118484248] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1063; }","duration":"144.403965ms","start":"2026-06-09T01:12:44.928897Z","end":"2026-06-09T01:12:45.073301Z","steps":["trace[1118484248] 'agreement among raft nodes before linearized reading' (duration: 144.290143ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:45.073383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.922183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:12:45.07341Z","caller":"traceutil/trace.go:171","msg":"trace[385131570] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1063; }","duration":"689.986855ms","start":"2026-06-09T01:12:44.383416Z","end":"2026-06-09T01:12:45.073403Z","steps":["trace[385131570] 'agreement among raft nodes before linearized reading' (duration: 689.947544ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:45.073431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:12:44.383397Z","time spent":"690.030465ms","remote":"127.0.0.1:47256","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-09T01:12:45.534415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.687265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T01:12:45.534473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.545525ms","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-09T01:12:45.534492Z","caller":"traceutil/trace.go:171","msg":"trace[1894093221] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1063; }","duration":"150.772017ms","start":"2026-06-09T01:12:45.383701Z","end":"2026-06-09T01:12:45.534473Z","steps":["trace[1894093221] 'range keys from in-memory index tree' (duration: 150.584874ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:12:45.534556Z","caller":"traceutil/trace.go:171","msg":"trace[1296407671] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1063; }","duration":"141.649047ms","start":"2026-06-09T01:12:45.392875Z","end":"2026-06-09T01:12:45.534524Z","steps":["trace[1296407671] 'range keys from in-memory index tree' (duration: 141.416683ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:12:45.687455Z","caller":"traceutil/trace.go:171","msg":"trace[986316374] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"147.943988ms","start":"2026-06-09T01:12:45.539491Z","end":"2026-06-09T01:12:45.687435Z","steps":["trace[986316374] 'process raft request' (duration: 147.759054ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:12:45.91926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.138805ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-06-09T01:12:46.429833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.20154ms","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-09T01:12:46.429868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.664632ms","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-09T01:12:46.429868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.884825ms","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-09T01:12:46.429934Z","caller":"traceutil/trace.go:171","msg":"trace[1171367672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1066; }","duration":"162.367363ms","start":"2026-06-09T01:12:46.267542Z","end":"2026-06-09T01:12:46.42991Z","steps":["trace[1171367672] 'range keys from in-memory index tree' (duration: 161.996977ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:12:46.429944Z","caller":"traceutil/trace.go:171","msg":"trace[1026444373] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1066; }","duration":"124.025477ms","start":"2026-06-09T01:12:46.305907Z","end":"2026-06-09T01:12:46.429932Z","steps":["trace[1026444373] 'range keys from in-memory index tree' (duration: 123.709961ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:12:46.429944Z","caller":"traceutil/trace.go:171","msg":"trace[1053475366] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1066; }","duration":"165.783213ms","start":"2026-06-09T01:12:46.264143Z","end":"2026-06-09T01:12:46.429926Z","steps":["trace[1053475366] 'range keys from in-memory index tree' (duration: 165.501049ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:12:46.624487Z","caller":"traceutil/trace.go:171","msg":"trace[987160141] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"189.289478ms","start":"2026-06-09T01:12:46.435174Z","end":"2026-06-09T01:12:46.624463Z","steps":["trace[987160141] 'process raft request' (duration: 189.221657ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:12:46.62449Z","caller":"traceutil/trace.go:171","msg":"trace[1910166888] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"190.604081ms","start":"2026-06-09T01:12:46.433861Z","end":"2026-06-09T01:12:46.624465Z","steps":["trace[1910166888] 'process raft request' (duration: 163.603454ms)","trace[1910166888] 'compare' (duration: 26.708572ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:12:47.240041Z","caller":"traceutil/trace.go:171","msg":"trace[1939788659] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"155.497431ms","start":"2026-06-09T01:12:47.084522Z","end":"2026-06-09T01:12:47.240019Z","steps":["trace[1939788659] 'process raft request' (duration: 155.376319ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:12:52.669962Z","caller":"traceutil/trace.go:171","msg":"trace[1939992786] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"129.690727ms","start":"2026-06-09T01:12:52.540246Z","end":"2026-06-09T01:12:52.669937Z","steps":["trace[1939992786] 'process raft request' (duration: 129.428271ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:13:01.645231Z","caller":"traceutil/trace.go:171","msg":"trace[787459123] linearizableReadLoop","detail":"{readStateIndex:1219; appliedIndex:1218; }","duration":"261.132444ms","start":"2026-06-09T01:13:01.384076Z","end":"2026-06-09T01:13:01.645209Z","steps":["trace[787459123] 'read index received' (duration: 260.975101ms)","trace[787459123] 'applied index is now lower than readState.Index' (duration: 156.413µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:13:01.645375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.282396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:13:01.645406Z","caller":"traceutil/trace.go:171","msg":"trace[1473917691] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1167; }","duration":"261.352598ms","start":"2026-06-09T01:13:01.384045Z","end":"2026-06-09T01:13:01.645397Z","steps":["trace[1473917691] 'agreement among raft nodes before linearized reading' (duration: 261.256576ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:13:01.645754Z","caller":"traceutil/trace.go:171","msg":"trace[1600902688] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"345.382348ms","start":"2026-06-09T01:13:01.300346Z","end":"2026-06-09T01:13:01.645729Z","steps":["trace[1600902688] 'process raft request' (duration: 344.721177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:01.645849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:01.300335Z","time spent":"345.446439ms","remote":"127.0.0.1:47472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:13:03.214885Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853971040938221105,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T01:13:03.526269Z","caller":"traceutil/trace.go:171","msg":"trace[715048330] linearizableReadLoop","detail":"{readStateIndex:1222; appliedIndex:1221; }","duration":"812.381851ms","start":"2026-06-09T01:13:02.713871Z","end":"2026-06-09T01:13:03.526253Z","steps":["trace[715048330] 'read index received' (duration: 812.201818ms)","trace[715048330] 'applied index is now lower than readState.Index' (duration: 175.963µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:13:03.526372Z","caller":"traceutil/trace.go:171","msg":"trace[685380979] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"903.569219ms","start":"2026-06-09T01:13:02.622796Z","end":"2026-06-09T01:13:03.526365Z","steps":["trace[685380979] 'process raft request' (duration: 903.343245ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:03.526458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:02.622773Z","time spent":"903.622651ms","remote":"127.0.0.1:47472","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-09T01:13:03.526668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.710536ms","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-09T01:13:03.526739Z","caller":"traceutil/trace.go:171","msg":"trace[333748399] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1170; }","duration":"800.805768ms","start":"2026-06-09T01:13:02.725917Z","end":"2026-06-09T01:13:03.526722Z","steps":["trace[333748399] 'agreement among raft nodes before linearized reading' (duration: 800.623565ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:03.526773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.215776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T01:13:03.526804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:02.725909Z","time spent":"800.885859ms","remote":"127.0.0.1:47472","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-09T01:13:03.526894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.019984ms","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-09T01:13:03.526921Z","caller":"traceutil/trace.go:171","msg":"trace[1358929222] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1170; }","duration":"813.070324ms","start":"2026-06-09T01:13:02.713845Z","end":"2026-06-09T01:13:03.526915Z","steps":["trace[1358929222] 'agreement among raft nodes before linearized reading' (duration: 812.980623ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:03.526946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:02.713833Z","time spent":"813.108275ms","remote":"127.0.0.1:47472","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-09T01:13:03.527081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"763.114803ms","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-09T01:13:03.526815Z","caller":"traceutil/trace.go:171","msg":"trace[378453588] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1170; }","duration":"143.288496ms","start":"2026-06-09T01:13:03.383519Z","end":"2026-06-09T01:13:03.526807Z","steps":["trace[378453588] 'agreement among raft nodes before linearized reading' (duration: 143.229405ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:13:03.52713Z","caller":"traceutil/trace.go:171","msg":"trace[237141719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1170; }","duration":"763.199955ms","start":"2026-06-09T01:13:02.763921Z","end":"2026-06-09T01:13:03.527121Z","steps":["trace[237141719] 'agreement among raft nodes before linearized reading' (duration: 763.063632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:03.52716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:02.763902Z","time spent":"763.250785ms","remote":"127.0.0.1:47472","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-09T01:13:04.150707Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853971040938221109,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T01:13:04.235467Z","caller":"traceutil/trace.go:171","msg":"trace[233808667] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"704.865778ms","start":"2026-06-09T01:13:03.530574Z","end":"2026-06-09T01:13:04.23544Z","steps":["trace[233808667] 'process raft request' (duration: 704.713555ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:04.235635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:03.530555Z","time spent":"704.992009ms","remote":"127.0.0.1:47472","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-09T01:13:04.236808Z","caller":"traceutil/trace.go:171","msg":"trace[642147165] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"705.598979ms","start":"2026-06-09T01:13:03.53119Z","end":"2026-06-09T01:13:04.236789Z","steps":["trace[642147165] 'process raft request' (duration: 705.551588ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:13:04.236913Z","caller":"traceutil/trace.go:171","msg":"trace[1302208024] linearizableReadLoop","detail":"{readStateIndex:1226; appliedIndex:1222; }","duration":"586.542571ms","start":"2026-06-09T01:13:03.650357Z","end":"2026-06-09T01:13:04.2369Z","steps":["trace[1302208024] 'read index received' (duration: 585.012954ms)","trace[1302208024] 'applied index is now lower than readState.Index' (duration: 1.528367ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:13:04.236932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:03.531181Z","time spent":"705.681371ms","remote":"127.0.0.1:47472","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-09T01:13:04.237007Z","caller":"traceutil/trace.go:171","msg":"trace[383826420] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"185.569262ms","start":"2026-06-09T01:13:04.051426Z","end":"2026-06-09T01:13:04.236995Z","steps":["trace[383826420] 'process raft request' (duration: 185.335438ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:13:04.236978Z","caller":"traceutil/trace.go:171","msg":"trace[759712108] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"706.250001ms","start":"2026-06-09T01:13:03.530704Z","end":"2026-06-09T01:13:04.236954Z","steps":["trace[759712108] 'process raft request' (duration: 705.932616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:04.237165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.47955ms","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-09T01:13:04.237195Z","caller":"traceutil/trace.go:171","msg":"trace[1201783604] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1174; }","duration":"366.563012ms","start":"2026-06-09T01:13:03.870624Z","end":"2026-06-09T01:13:04.237187Z","steps":["trace[1201783604] 'agreement among raft nodes before linearized reading' (duration: 366.45204ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:04.237214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:03.870593Z","time spent":"366.615553ms","remote":"127.0.0.1:47472","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-09T01:13:04.237317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.961508ms","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-09T01:13:04.237342Z","caller":"traceutil/trace.go:171","msg":"trace[1763694258] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1174; }","duration":"587.015258ms","start":"2026-06-09T01:13:03.650319Z","end":"2026-06-09T01:13:04.237335Z","steps":["trace[1763694258] 'agreement among raft nodes before linearized reading' (duration: 586.907107ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:04.237361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:03.650296Z","time spent":"587.05858ms","remote":"127.0.0.1:47472","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-09T01:13:04.23929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:03.530696Z","time spent":"708.154454ms","remote":"127.0.0.1:47472","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-09T01:13:20.629576Z","caller":"traceutil/trace.go:171","msg":"trace[73273601] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"448.08144ms","start":"2026-06-09T01:13:20.181478Z","end":"2026-06-09T01:13:20.629559Z","steps":["trace[73273601] 'process raft request' (duration: 447.942898ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:20.629695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:20.181455Z","time spent":"448.181493ms","remote":"127.0.0.1:47480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1508,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:13:21.355922Z","caller":"traceutil/trace.go:171","msg":"trace[1683451658] linearizableReadLoop","detail":"{readStateIndex:1298; appliedIndex:1294; }","duration":"1.037189387s","start":"2026-06-09T01:13:20.31871Z","end":"2026-06-09T01:13:21.355899Z","steps":["trace[1683451658] 'read index received' (duration: 310.760749ms)","trace[1683451658] 'applied index is now lower than readState.Index' (duration: 726.427648ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:13:21.356217Z","caller":"traceutil/trace.go:171","msg":"trace[269043590] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"1.039393251s","start":"2026-06-09T01:13:20.316801Z","end":"2026-06-09T01:13:21.356194Z","steps":["trace[269043590] 'process raft request' (duration: 1.039058884s)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:13:21.35631Z","caller":"traceutil/trace.go:171","msg":"trace[1861391910] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"1.169606282s","start":"2026-06-09T01:13:20.186669Z","end":"2026-06-09T01:13:21.356275Z","steps":["trace[1861391910] 'process raft request' (duration: 1.169139953s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:21.356323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:20.316747Z","time spent":"1.039522683s","remote":"127.0.0.1:47472","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-09T01:13:21.356383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:20.186651Z","time spent":"1.169694485s","remote":"127.0.0.1:47680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9375,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:13:21.356394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.024353944s","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-09T01:13:21.356409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"992.860001ms","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-09T01:13:21.356445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"993.048454ms","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-09T01:13:21.356488Z","caller":"traceutil/trace.go:171","msg":"trace[401765745] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1243; }","duration":"993.121896ms","start":"2026-06-09T01:13:20.363355Z","end":"2026-06-09T01:13:21.356477Z","steps":["trace[401765745] 'agreement among raft nodes before linearized reading' (duration: 993.021274ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:21.356517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:20.363338Z","time spent":"993.171077ms","remote":"127.0.0.1:47472","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-09T01:13:21.356531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.616572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.116\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-09T01:13:21.35656Z","caller":"traceutil/trace.go:171","msg":"trace[903855142] range","detail":"{range_begin:/registry/masterleases/199.204.45.116; range_end:; response_count:1; response_revision:1243; }","duration":"647.680553ms","start":"2026-06-09T01:13:20.708872Z","end":"2026-06-09T01:13:21.356553Z","steps":["trace[903855142] 'agreement among raft nodes before linearized reading' (duration: 647.601921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:21.356552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.022696779s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-09T01:13:21.356586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:20.708851Z","time spent":"647.729564ms","remote":"127.0.0.1:47282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.116\" "} {"level":"warn","ts":"2026-06-09T01:13:21.35659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"974.11541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:13:21.356603Z","caller":"traceutil/trace.go:171","msg":"trace[1407506649] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1243; }","duration":"1.022777911s","start":"2026-06-09T01:13:20.333815Z","end":"2026-06-09T01:13:21.356593Z","steps":["trace[1407506649] 'agreement among raft nodes before linearized reading' (duration: 1.022654279s)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:13:21.356613Z","caller":"traceutil/trace.go:171","msg":"trace[2000166824] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1243; }","duration":"974.176732ms","start":"2026-06-09T01:13:20.38243Z","end":"2026-06-09T01:13:21.356606Z","steps":["trace[2000166824] 'agreement among raft nodes before linearized reading' (duration: 974.143381ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:13:21.356447Z","caller":"traceutil/trace.go:171","msg":"trace[338086888] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1243; }","duration":"1.024431705s","start":"2026-06-09T01:13:20.331999Z","end":"2026-06-09T01:13:21.356431Z","steps":["trace[338086888] 'agreement among raft nodes before linearized reading' (duration: 1.024251102s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:21.356635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:20.382405Z","time spent":"974.226043ms","remote":"127.0.0.1:47258","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-09T01:13:21.35664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:20.333798Z","time spent":"1.022832932s","remote":"127.0.0.1:47472","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-09T01:13:21.356652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:20.331945Z","time spent":"1.02469566s","remote":"127.0.0.1:47472","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-09T01:13:21.356453Z","caller":"traceutil/trace.go:171","msg":"trace[441965489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1243; }","duration":"992.940912ms","start":"2026-06-09T01:13:20.3635Z","end":"2026-06-09T01:13:21.356441Z","steps":["trace[441965489] 'agreement among raft nodes before linearized reading' (duration: 992.780759ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:21.356743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:20.36348Z","time spent":"993.255218ms","remote":"127.0.0.1:47472","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-09T01:13:21.358634Z","caller":"traceutil/trace.go:171","msg":"trace[2112334715] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"1.17707809s","start":"2026-06-09T01:13:20.181537Z","end":"2026-06-09T01:13:21.358615Z","steps":["trace[2112334715] 'process raft request' (duration: 1.174138861s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:21.358704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:20.181507Z","time spent":"1.177162992s","remote":"127.0.0.1:47388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":915,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:13:21.359104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.04038939s","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-09T01:13:21.35914Z","caller":"traceutil/trace.go:171","msg":"trace[1262999514] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1243; }","duration":"1.040425391s","start":"2026-06-09T01:13:20.318704Z","end":"2026-06-09T01:13:21.35913Z","steps":["trace[1262999514] 'agreement among raft nodes before linearized reading' (duration: 1.040297678s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:21.359165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:20.318692Z","time spent":"1.040467641s","remote":"127.0.0.1:47472","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-09T01:13:23.752141Z","caller":"traceutil/trace.go:171","msg":"trace[1282662797] linearizableReadLoop","detail":"{readStateIndex:1307; appliedIndex:1306; }","duration":"370.611401ms","start":"2026-06-09T01:13:23.38151Z","end":"2026-06-09T01:13:23.752121Z","steps":["trace[1282662797] 'read index received' (duration: 370.387807ms)","trace[1282662797] 'applied index is now lower than readState.Index' (duration: 222.724µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:13:23.752175Z","caller":"traceutil/trace.go:171","msg":"trace[569377789] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"390.774659ms","start":"2026-06-09T01:13:23.361371Z","end":"2026-06-09T01:13:23.752146Z","steps":["trace[569377789] 'process raft request' (duration: 390.618036ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:23.752321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:23.361341Z","time spent":"390.90048ms","remote":"127.0.0.1:47472","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-09T01:13:23.752372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.453355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-09T01:13:23.752366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.838745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:13:23.752417Z","caller":"traceutil/trace.go:171","msg":"trace[46237656] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1251; }","duration":"339.530676ms","start":"2026-06-09T01:13:23.412868Z","end":"2026-06-09T01:13:23.752399Z","steps":["trace[46237656] 'agreement among raft nodes before linearized reading' (duration: 339.375743ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:13:23.752445Z","caller":"traceutil/trace.go:171","msg":"trace[1426737903] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1251; }","duration":"370.958317ms","start":"2026-06-09T01:13:23.381467Z","end":"2026-06-09T01:13:23.752425Z","steps":["trace[1426737903] 'agreement among raft nodes before linearized reading' (duration: 370.788524ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:23.752491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:23.381443Z","time spent":"371.036339ms","remote":"127.0.0.1:47256","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-09T01:13:23.752488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:23.412843Z","time spent":"339.628888ms","remote":"127.0.0.1:47472","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-09T01:13:23.75253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.426304ms","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-09T01:13:23.752591Z","caller":"traceutil/trace.go:171","msg":"trace[2064740999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1251; }","duration":"339.516736ms","start":"2026-06-09T01:13:23.413062Z","end":"2026-06-09T01:13:23.752578Z","steps":["trace[2064740999] 'agreement among raft nodes before linearized reading' (duration: 339.321162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:23.752622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:23.413053Z","time spent":"339.564147ms","remote":"127.0.0.1:47472","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-09T01:13:23.752621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.554476ms","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-09T01:13:23.752734Z","caller":"traceutil/trace.go:171","msg":"trace[732830022] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1251; }","duration":"339.672759ms","start":"2026-06-09T01:13:23.413049Z","end":"2026-06-09T01:13:23.752722Z","steps":["trace[732830022] 'agreement among raft nodes before linearized reading' (duration: 339.279431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:23.7525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.455195ms","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-09T01:13:23.752771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:23.413044Z","time spent":"339.719549ms","remote":"127.0.0.1:47472","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-09T01:13:23.752791Z","caller":"traceutil/trace.go:171","msg":"trace[1067821562] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1251; }","duration":"339.76787ms","start":"2026-06-09T01:13:23.413004Z","end":"2026-06-09T01:13:23.752772Z","steps":["trace[1067821562] 'agreement among raft nodes before linearized reading' (duration: 339.380643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:23.752847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:23.412987Z","time spent":"339.843983ms","remote":"127.0.0.1:47472","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-09T01:13:23.752643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.71577ms","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-09T01:13:23.752985Z","caller":"traceutil/trace.go:171","msg":"trace[1844777475] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1251; }","duration":"340.103618ms","start":"2026-06-09T01:13:23.412867Z","end":"2026-06-09T01:13:23.752971Z","steps":["trace[1844777475] 'agreement among raft nodes before linearized reading' (duration: 339.536596ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:23.753033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:23.412839Z","time spent":"340.182029ms","remote":"127.0.0.1:47472","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-09T01:13:23.926664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.415054ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T01:13:23.926739Z","caller":"traceutil/trace.go:171","msg":"trace[432275607] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"169.269024ms","start":"2026-06-09T01:13:23.757457Z","end":"2026-06-09T01:13:23.926726Z","steps":["trace[432275607] 'process raft request' (duration: 66.725217ms)","trace[432275607] 'compare' (duration: 102.23429ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:13:23.957865Z","caller":"traceutil/trace.go:171","msg":"trace[648470372] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"199.757966ms","start":"2026-06-09T01:13:23.75809Z","end":"2026-06-09T01:13:23.957848Z","steps":["trace[648470372] 'process raft request' (duration: 199.701825ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:13:23.958286Z","caller":"traceutil/trace.go:171","msg":"trace[382548546] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"200.652323ms","start":"2026-06-09T01:13:23.757621Z","end":"2026-06-09T01:13:23.958273Z","steps":["trace[382548546] 'process raft request' (duration: 200.009731ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:13:23.958532Z","caller":"traceutil/trace.go:171","msg":"trace[1617410993] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"200.888778ms","start":"2026-06-09T01:13:23.757632Z","end":"2026-06-09T01:13:23.958521Z","steps":["trace[1617410993] 'process raft request' (duration: 200.077952ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:13:23.958713Z","caller":"traceutil/trace.go:171","msg":"trace[480292935] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"200.994701ms","start":"2026-06-09T01:13:23.757646Z","end":"2026-06-09T01:13:23.958641Z","steps":["trace[480292935] 'process raft request' (duration: 200.094623ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:13:23.980271Z","caller":"traceutil/trace.go:171","msg":"trace[1167307215] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"127.205483ms","start":"2026-06-09T01:13:23.853026Z","end":"2026-06-09T01:13:23.980231Z","steps":["trace[1167307215] 'process raft request' (duration: 127.071101ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:25.177734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.181184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T01:13:25.177897Z","caller":"traceutil/trace.go:171","msg":"trace[2032320986] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1263; }","duration":"444.392607ms","start":"2026-06-09T01:13:24.733487Z","end":"2026-06-09T01:13:25.177879Z","steps":["trace[2032320986] 'count revisions from in-memory index tree' (duration: 444.097962ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:25.177942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:24.733467Z","time spent":"444.462069ms","remote":"127.0.0.1:42312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-06-09T01:13:28.098091Z","caller":"traceutil/trace.go:171","msg":"trace[616812572] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"121.090693ms","start":"2026-06-09T01:13:27.976984Z","end":"2026-06-09T01:13:28.098074Z","steps":["trace[616812572] 'process raft request' (duration: 81.670494ms)","trace[616812572] 'compare' (duration: 39.294896ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:13:28.098393Z","caller":"traceutil/trace.go:171","msg":"trace[1699150385] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"120.555381ms","start":"2026-06-09T01:13:27.977806Z","end":"2026-06-09T01:13:28.098361Z","steps":["trace[1699150385] 'process raft request' (duration: 120.245365ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:13:28.098459Z","caller":"traceutil/trace.go:171","msg":"trace[1867836326] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"119.598483ms","start":"2026-06-09T01:13:27.978831Z","end":"2026-06-09T01:13:28.09843Z","steps":["trace[1867836326] 'process raft request' (duration: 119.422989ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:13:28.098525Z","caller":"traceutil/trace.go:171","msg":"trace[1355343601] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"117.680385ms","start":"2026-06-09T01:13:27.98081Z","end":"2026-06-09T01:13:28.09849Z","steps":["trace[1355343601] 'process raft request' (duration: 117.524622ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:34.468305Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853971040938221428,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-09T01:13:34.651317Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.053509056s","expected-duration":"1s"} {"level":"info","ts":"2026-06-09T01:13:34.651816Z","caller":"traceutil/trace.go:171","msg":"trace[151575682] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"1.054076118s","start":"2026-06-09T01:13:33.597716Z","end":"2026-06-09T01:13:34.651792Z","steps":["trace[151575682] 'process raft request' (duration: 1.053788023s)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:34.652342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:33.597701Z","time spent":"1.054400034s","remote":"127.0.0.1:47472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:13:34.652586Z","caller":"traceutil/trace.go:171","msg":"trace[1107866488] linearizableReadLoop","detail":"{readStateIndex:1386; appliedIndex:1383; }","duration":"684.807845ms","start":"2026-06-09T01:13:33.96776Z","end":"2026-06-09T01:13:34.652568Z","steps":["trace[1107866488] 'read index received' (duration: 683.795756ms)","trace[1107866488] 'applied index is now lower than readState.Index' (duration: 1.011259ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:13:34.652648Z","caller":"traceutil/trace.go:171","msg":"trace[1632314465] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"486.340504ms","start":"2026-06-09T01:13:34.166301Z","end":"2026-06-09T01:13:34.652641Z","steps":["trace[1632314465] 'process raft request' (duration: 486.221632ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:13:34.652695Z","caller":"traceutil/trace.go:171","msg":"trace[629120982] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"835.273846ms","start":"2026-06-09T01:13:33.817363Z","end":"2026-06-09T01:13:34.652636Z","steps":["trace[629120982] 'process raft request' (duration: 835.033072ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:34.652739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:34.166279Z","time spent":"486.395496ms","remote":"127.0.0.1:47472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:13:34.653087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:33.817343Z","time spent":"835.629154ms","remote":"127.0.0.1:47472","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-09T01:13:34.65318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.10757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-09T01:13:34.653208Z","caller":"traceutil/trace.go:171","msg":"trace[1682725083] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1328; }","duration":"528.157101ms","start":"2026-06-09T01:13:34.125045Z","end":"2026-06-09T01:13:34.653202Z","steps":["trace[1682725083] 'agreement among raft nodes before linearized reading' (duration: 528.068029ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:34.653229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:34.125Z","time spent":"528.223203ms","remote":"127.0.0.1:47472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-09T01:13:34.653313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.544261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-06-09T01:13:34.653335Z","caller":"traceutil/trace.go:171","msg":"trace[579497281] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1328; }","duration":"439.604841ms","start":"2026-06-09T01:13:34.213725Z","end":"2026-06-09T01:13:34.65333Z","steps":["trace[579497281] 'agreement among raft nodes before linearized reading' (duration: 439.55162ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:34.653351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:34.213704Z","time spent":"439.643543ms","remote":"127.0.0.1:47472","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":552,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-09T01:13:34.653366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.221141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-06-09T01:13:34.65341Z","caller":"traceutil/trace.go:171","msg":"trace[262591822] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1328; }","duration":"175.304923ms","start":"2026-06-09T01:13:34.478092Z","end":"2026-06-09T01:13:34.653397Z","steps":["trace[262591822] 'agreement among raft nodes before linearized reading' (duration: 175.14933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:34.653435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.722691ms","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-09T01:13:34.653452Z","caller":"traceutil/trace.go:171","msg":"trace[311691754] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1328; }","duration":"529.773943ms","start":"2026-06-09T01:13:34.123672Z","end":"2026-06-09T01:13:34.653446Z","steps":["trace[311691754] 'agreement among raft nodes before linearized reading' (duration: 529.731252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:34.653469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:34.123651Z","time spent":"529.813724ms","remote":"127.0.0.1:47472","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-09T01:13:34.65356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.886786ms","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-09T01:13:34.653587Z","caller":"traceutil/trace.go:171","msg":"trace[17967017] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1328; }","duration":"528.932857ms","start":"2026-06-09T01:13:34.124647Z","end":"2026-06-09T01:13:34.65358Z","steps":["trace[17967017] 'agreement among raft nodes before linearized reading' (duration: 528.865456ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:34.653605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:34.12464Z","time spent":"528.961217ms","remote":"127.0.0.1:47472","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-09T01:13:34.653673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.912827ms","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-09T01:13:34.653733Z","caller":"traceutil/trace.go:171","msg":"trace[1694938263] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1328; }","duration":"686.002969ms","start":"2026-06-09T01:13:33.967719Z","end":"2026-06-09T01:13:34.653722Z","steps":["trace[1694938263] 'agreement among raft nodes before linearized reading' (duration: 685.783865ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:34.653769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:33.967702Z","time spent":"686.06009ms","remote":"127.0.0.1:47472","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-09T01:13:34.653753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.408101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-09T01:13:34.654327Z","caller":"traceutil/trace.go:171","msg":"trace[738934396] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1328; }","duration":"670.573363ms","start":"2026-06-09T01:13:33.983712Z","end":"2026-06-09T01:13:34.654285Z","steps":["trace[738934396] 'agreement among raft nodes before linearized reading' (duration: 669.319949ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:34.654456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:33.983694Z","time spent":"670.707726ms","remote":"127.0.0.1:47724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":140,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-06-09T01:13:34.65422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.778552ms","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-09T01:13:34.654821Z","caller":"traceutil/trace.go:171","msg":"trace[1572008156] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1328; }","duration":"532.250602ms","start":"2026-06-09T01:13:34.122393Z","end":"2026-06-09T01:13:34.654643Z","steps":["trace[1572008156] 'agreement among raft nodes before linearized reading' (duration: 531.742292ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:13:34.654879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:13:34.122359Z","time spent":"532.504866ms","remote":"127.0.0.1:47472","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":"info","ts":"2026-06-09T01:14:04.866285Z","caller":"traceutil/trace.go:171","msg":"trace[1856207914] transaction","detail":"{read_only:false; response_revision:1466; number_of_response:1; }","duration":"136.065457ms","start":"2026-06-09T01:14:04.730143Z","end":"2026-06-09T01:14:04.866208Z","steps":["trace[1856207914] 'process raft request' (duration: 123.853557ms)","trace[1856207914] 'compare' (duration: 12.128659ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:14:11.121016Z","caller":"traceutil/trace.go:171","msg":"trace[1724760060] transaction","detail":"{read_only:false; response_revision:1500; number_of_response:1; }","duration":"102.929343ms","start":"2026-06-09T01:14:11.018065Z","end":"2026-06-09T01:14:11.120995Z","steps":["trace[1724760060] 'process raft request' (duration: 102.570745ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:14:11.121317Z","caller":"traceutil/trace.go:171","msg":"trace[1736711118] transaction","detail":"{read_only:false; response_revision:1501; number_of_response:1; }","duration":"102.865182ms","start":"2026-06-09T01:14:11.018433Z","end":"2026-06-09T01:14:11.121298Z","steps":["trace[1736711118] 'process raft request' (duration: 102.519666ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:14:11.1214Z","caller":"traceutil/trace.go:171","msg":"trace[1744954733] transaction","detail":"{read_only:false; response_revision:1502; number_of_response:1; }","duration":"102.563755ms","start":"2026-06-09T01:14:11.018803Z","end":"2026-06-09T01:14:11.121367Z","steps":["trace[1744954733] 'process raft request' (duration: 102.411673ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:14:19.105293Z","caller":"traceutil/trace.go:171","msg":"trace[1788602584] transaction","detail":"{read_only:false; response_revision:1531; number_of_response:1; }","duration":"149.886865ms","start":"2026-06-09T01:14:18.955382Z","end":"2026-06-09T01:14:19.105269Z","steps":["trace[1788602584] 'process raft request' (duration: 149.691711ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:14:19.230064Z","caller":"traceutil/trace.go:171","msg":"trace[1820474017] transaction","detail":"{read_only:false; response_revision:1532; number_of_response:1; }","duration":"120.026041ms","start":"2026-06-09T01:14:19.110001Z","end":"2026-06-09T01:14:19.230027Z","steps":["trace[1820474017] 'process raft request' (duration: 65.12184ms)","trace[1820474017] 'compare' (duration: 54.769629ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:14:19.233965Z","caller":"traceutil/trace.go:171","msg":"trace[1344333859] transaction","detail":"{read_only:false; response_revision:1534; number_of_response:1; }","duration":"122.655214ms","start":"2026-06-09T01:14:19.111251Z","end":"2026-06-09T01:14:19.233906Z","steps":["trace[1344333859] 'process raft request' (duration: 122.611473ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:14:19.23404Z","caller":"traceutil/trace.go:171","msg":"trace[1309731144] transaction","detail":"{read_only:false; response_revision:1533; number_of_response:1; }","duration":"123.887698ms","start":"2026-06-09T01:14:19.110083Z","end":"2026-06-09T01:14:19.233971Z","steps":["trace[1309731144] 'process raft request' (duration: 123.633623ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:14:30.048168Z","caller":"traceutil/trace.go:171","msg":"trace[2143888105] transaction","detail":"{read_only:false; response_revision:1585; number_of_response:1; }","duration":"135.357242ms","start":"2026-06-09T01:14:29.912785Z","end":"2026-06-09T01:14:30.048143Z","steps":["trace[2143888105] 'process raft request' (duration: 135.205879ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:16:10.337328Z","caller":"traceutil/trace.go:171","msg":"trace[262082469] linearizableReadLoop","detail":"{readStateIndex:2133; appliedIndex:2132; }","duration":"102.512049ms","start":"2026-06-09T01:16:10.234783Z","end":"2026-06-09T01:16:10.337295Z","steps":["trace[262082469] 'read index received' (duration: 75.099232ms)","trace[262082469] 'applied index is now lower than readState.Index' (duration: 27.411167ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:16:10.337337Z","caller":"traceutil/trace.go:171","msg":"trace[528579388] transaction","detail":"{read_only:false; response_revision:2044; number_of_response:1; }","duration":"205.434257ms","start":"2026-06-09T01:16:10.131871Z","end":"2026-06-09T01:16:10.337305Z","steps":["trace[528579388] 'process raft request' (duration: 178.067321ms)","trace[528579388] 'compare' (duration: 27.089071ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:16:10.337537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.733973ms","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-09T01:16:10.337588Z","caller":"traceutil/trace.go:171","msg":"trace[1140952680] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2044; }","duration":"102.820115ms","start":"2026-06-09T01:16:10.234755Z","end":"2026-06-09T01:16:10.337576Z","steps":["trace[1140952680] 'agreement among raft nodes before linearized reading' (duration: 102.648392ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:17:28.693272Z","caller":"traceutil/trace.go:171","msg":"trace[567653537] transaction","detail":"{read_only:false; response_revision:2427; number_of_response:1; }","duration":"168.19801ms","start":"2026-06-09T01:17:28.525036Z","end":"2026-06-09T01:17:28.693234Z","steps":["trace[567653537] 'process raft request' (duration: 167.949625ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:17:28.693345Z","caller":"traceutil/trace.go:171","msg":"trace[1527427678] transaction","detail":"{read_only:false; response_revision:2428; number_of_response:1; }","duration":"168.261171ms","start":"2026-06-09T01:17:28.525044Z","end":"2026-06-09T01:17:28.693305Z","steps":["trace[1527427678] 'process raft request' (duration: 168.098248ms)"],"step_count":1}