{"level":"warn","ts":"2026-06-28T19:56:24.587385Z","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-28T19:56:24.587467Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.129: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.129:2380","--initial-cluster=instance=https://199.204.45.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.129: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-28T19:56:24.587533Z","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-28T19:56:24.587547Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-06-28T19:56:24.587562Z","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-28T19:56:24.588184Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"]} {"level":"info","ts":"2026-06-28T19:56:24.588259Z","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.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.129: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-28T19:56:24.592335Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.864353ms"} {"level":"info","ts":"2026-06-28T19:56:24.599729Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cec112083e8d3ff","cluster-id":"3f68255a3b440659"} {"level":"info","ts":"2026-06-28T19:56:24.599807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=()"} {"level":"info","ts":"2026-06-28T19:56:24.599831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 0"} {"level":"info","ts":"2026-06-28T19:56:24.59985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cec112083e8d3ff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-28T19:56:24.599861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 1"} {"level":"info","ts":"2026-06-28T19:56:24.5999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"warn","ts":"2026-06-28T19:56:24.605249Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-28T19:56:24.606819Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-28T19:56:24.613088Z","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-28T19:56:24.618726Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cec112083e8d3ff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-28T19:56:24.619291Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cec112083e8d3ff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-28T19:56:24.619371Z","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-28T19:56:24.619582Z","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-28T19:56:24.619598Z","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-28T19:56:24.620295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"info","ts":"2026-06-28T19:56:24.620498Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","added-peer-id":"3cec112083e8d3ff","added-peer-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-06-28T19:56:24.624209Z","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-28T19:56:24.624278Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-06-28T19:56:24.624368Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-06-28T19:56:24.625455Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cec112083e8d3ff","initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-28T19:56:24.625629Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-28T19:56:25.106712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff is starting a new election at term 1"} {"level":"info","ts":"2026-06-28T19:56:25.106859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became pre-candidate at term 1"} {"level":"info","ts":"2026-06-28T19:56:25.106974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgPreVoteResp from 3cec112083e8d3ff at term 1"} {"level":"info","ts":"2026-06-28T19:56:25.107042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became candidate at term 2"} {"level":"info","ts":"2026-06-28T19:56:25.107082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgVoteResp from 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-06-28T19:56:25.107161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became leader at term 2"} {"level":"info","ts":"2026-06-28T19:56:25.107202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cec112083e8d3ff elected leader 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-06-28T19:56:25.10823Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cec112083e8d3ff","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.129:2379]}","request-path":"/0/members/3cec112083e8d3ff/attributes","cluster-id":"3f68255a3b440659","publish-timeout":"7s"} {"level":"info","ts":"2026-06-28T19:56:25.10836Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-28T19:56:25.108861Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:56:25.109816Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-28T19:56:25.112189Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.129:2379"} {"level":"info","ts":"2026-06-28T19:56:25.11262Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:56:25.112679Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:56:25.112699Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:56:25.113416Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-28T19:56:25.118642Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-28T19:56:25.118702Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-28T19:56:48.940588Z","caller":"traceutil/trace.go:171","msg":"trace[1208823715] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"131.673073ms","start":"2026-06-28T19:56:48.808886Z","end":"2026-06-28T19:56:48.940559Z","steps":["trace[1208823715] 'process raft request' (duration: 55.002016ms)","trace[1208823715] 'compare' (duration: 76.537793ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:00.422955Z","caller":"traceutil/trace.go:171","msg":"trace[2121624764] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"223.883797ms","start":"2026-06-28T19:57:00.199047Z","end":"2026-06-28T19:57:00.422931Z","steps":["trace[2121624764] 'process raft request' (duration: 223.725452ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:00.43288Z","caller":"traceutil/trace.go:171","msg":"trace[1547643032] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"233.179043ms","start":"2026-06-28T19:57:00.199682Z","end":"2026-06-28T19:57:00.432861Z","steps":["trace[1547643032] 'process raft request' (duration: 233.018898ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:00.432945Z","caller":"traceutil/trace.go:171","msg":"trace[1667332216] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"225.387945ms","start":"2026-06-28T19:57:00.207517Z","end":"2026-06-28T19:57:00.432905Z","steps":["trace[1667332216] 'process raft request' (duration: 225.262871ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:00.433012Z","caller":"traceutil/trace.go:171","msg":"trace[1654674191] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"225.274261ms","start":"2026-06-28T19:57:00.207713Z","end":"2026-06-28T19:57:00.432988Z","steps":["trace[1654674191] 'process raft request' (duration: 225.130637ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:00.433091Z","caller":"traceutil/trace.go:171","msg":"trace[1246043921] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"223.98455ms","start":"2026-06-28T19:57:00.209066Z","end":"2026-06-28T19:57:00.43305Z","steps":["trace[1246043921] 'process raft request' (duration: 223.811485ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:00.433158Z","caller":"traceutil/trace.go:171","msg":"trace[1452593569] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"223.920028ms","start":"2026-06-28T19:57:00.209204Z","end":"2026-06-28T19:57:00.433124Z","steps":["trace[1452593569] 'process raft request' (duration: 223.719081ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:00.433409Z","caller":"traceutil/trace.go:171","msg":"trace[605830028] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"223.887866ms","start":"2026-06-28T19:57:00.209512Z","end":"2026-06-28T19:57:00.4334Z","steps":["trace[605830028] 'process raft request' (duration: 223.785483ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:00.433503Z","caller":"traceutil/trace.go:171","msg":"trace[419907937] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"223.031239ms","start":"2026-06-28T19:57:00.210462Z","end":"2026-06-28T19:57:00.433493Z","steps":["trace[419907937] 'process raft request' (duration: 222.902565ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:00.433637Z","caller":"traceutil/trace.go:171","msg":"trace[922306724] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"188.250599ms","start":"2026-06-28T19:57:00.245381Z","end":"2026-06-28T19:57:00.433631Z","steps":["trace[922306724] 'process raft request' (duration: 188.013541ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:00.433721Z","caller":"traceutil/trace.go:171","msg":"trace[2080906258] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"178.26935ms","start":"2026-06-28T19:57:00.255446Z","end":"2026-06-28T19:57:00.433715Z","steps":["trace[2080906258] 'process raft request' (duration: 178.010562ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:00.434031Z","caller":"traceutil/trace.go:171","msg":"trace[34461026] linearizableReadLoop","detail":"{readStateIndex:547; appliedIndex:539; }","duration":"204.780207ms","start":"2026-06-28T19:57:00.22924Z","end":"2026-06-28T19:57:00.43402Z","steps":["trace[34461026] 'read index received' (duration: 193.521648ms)","trace[34461026] 'applied index is now lower than readState.Index' (duration: 11.258079ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:00.434096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.841289ms","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-28T19:57:00.434137Z","caller":"traceutil/trace.go:171","msg":"trace[1050351036] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:531; }","duration":"204.914561ms","start":"2026-06-28T19:57:00.229216Z","end":"2026-06-28T19:57:00.434131Z","steps":["trace[1050351036] 'agreement among raft nodes before linearized reading' (duration: 204.842428ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:00.434196Z","caller":"traceutil/trace.go:171","msg":"trace[1321135197] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"140.759554ms","start":"2026-06-28T19:57:00.29343Z","end":"2026-06-28T19:57:00.43419Z","steps":["trace[1321135197] 'process raft request' (duration: 140.489245ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:00.43404Z","caller":"traceutil/trace.go:171","msg":"trace[1386592837] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"169.882963ms","start":"2026-06-28T19:57:00.26414Z","end":"2026-06-28T19:57:00.434023Z","steps":["trace[1386592837] 'process raft request' (duration: 169.45685ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:06.113323Z","caller":"traceutil/trace.go:171","msg":"trace[530613145] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"102.317656ms","start":"2026-06-28T19:57:06.010983Z","end":"2026-06-28T19:57:06.113301Z","steps":["trace[530613145] 'process raft request' (duration: 101.889992ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:06.380307Z","caller":"traceutil/trace.go:171","msg":"trace[311279770] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"154.309985ms","start":"2026-06-28T19:57:06.225973Z","end":"2026-06-28T19:57:06.380283Z","steps":["trace[311279770] 'read index received' (duration: 151.771624ms)","trace[311279770] 'applied index is now lower than readState.Index' (duration: 2.537161ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:06.381266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.203614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:06.381331Z","caller":"traceutil/trace.go:171","msg":"trace[854269653] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:624; }","duration":"155.329898ms","start":"2026-06-28T19:57:06.225981Z","end":"2026-06-28T19:57:06.381311Z","steps":["trace[854269653] 'agreement among raft nodes before linearized reading' (duration: 155.193724ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:06.383472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.114996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:06.383544Z","caller":"traceutil/trace.go:171","msg":"trace[1214766444] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:624; }","duration":"157.209819ms","start":"2026-06-28T19:57:06.226302Z","end":"2026-06-28T19:57:06.383512Z","steps":["trace[1214766444] 'agreement among raft nodes before linearized reading' (duration: 157.126176ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:06.383979Z","caller":"traceutil/trace.go:171","msg":"trace[659818874] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"189.84113ms","start":"2026-06-28T19:57:06.1941Z","end":"2026-06-28T19:57:06.383941Z","steps":["trace[659818874] 'process raft request' (duration: 184.403567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:06.384518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.526581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:06.384563Z","caller":"traceutil/trace.go:171","msg":"trace[1746987464] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:624; }","duration":"158.601323ms","start":"2026-06-28T19:57:06.225943Z","end":"2026-06-28T19:57:06.384545Z","steps":["trace[1746987464] 'agreement among raft nodes before linearized reading' (duration: 154.502372ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:06.603499Z","caller":"traceutil/trace.go:171","msg":"trace[1908784765] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"135.01775ms","start":"2026-06-28T19:57:06.468461Z","end":"2026-06-28T19:57:06.603478Z","steps":["trace[1908784765] 'read index received' (duration: 38.495339ms)","trace[1908784765] 'applied index is now lower than readState.Index' (duration: 96.521641ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:06.603692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.216196ms","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-28T19:57:06.603723Z","caller":"traceutil/trace.go:171","msg":"trace[2004906794] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:625; }","duration":"135.291538ms","start":"2026-06-28T19:57:06.468424Z","end":"2026-06-28T19:57:06.603715Z","steps":["trace[2004906794] 'agreement among raft nodes before linearized reading' (duration: 135.139983ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:06.603696Z","caller":"traceutil/trace.go:171","msg":"trace[1206538594] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"165.192392ms","start":"2026-06-28T19:57:06.438459Z","end":"2026-06-28T19:57:06.603652Z","steps":["trace[1206538594] 'process raft request' (duration: 68.558178ms)","trace[1206538594] 'compare' (duration: 96.355205ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:07.321092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.148447ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:57:07.321276Z","caller":"traceutil/trace.go:171","msg":"trace[780624204] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"114.305419ms","start":"2026-06-28T19:57:07.206943Z","end":"2026-06-28T19:57:07.321248Z","steps":["trace[780624204] 'process raft request' (duration: 114.243647ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:07.321478Z","caller":"traceutil/trace.go:171","msg":"trace[545824422] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"713.380682ms","start":"2026-06-28T19:57:06.608077Z","end":"2026-06-28T19:57:07.321458Z","steps":["trace[545824422] 'process raft request' (duration: 232.297605ms)","trace[545824422] 'compare' (duration: 479.962521ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:07.321541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:06.608054Z","time spent":"713.453733ms","remote":"127.0.0.1:32984","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-28T19:57:07.321688Z","caller":"traceutil/trace.go:171","msg":"trace[1487439825] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"706.786111ms","start":"2026-06-28T19:57:06.614892Z","end":"2026-06-28T19:57:07.321678Z","steps":["trace[1487439825] 'read index received' (duration: 225.429486ms)","trace[1487439825] 'applied index is now lower than readState.Index' (duration: 481.355535ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:07.322009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.112311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-n4m8m\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-28T19:57:07.322047Z","caller":"traceutil/trace.go:171","msg":"trace[1191561635] range","detail":"{range_begin:/registry/pods/kube-system/cilium-n4m8m; range_end:; response_count:1; response_revision:627; }","duration":"707.180653ms","start":"2026-06-28T19:57:06.614857Z","end":"2026-06-28T19:57:07.322038Z","steps":["trace[1191561635] 'agreement among raft nodes before linearized reading' (duration: 707.060509ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:07.322076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:06.614844Z","time spent":"707.224865ms","remote":"127.0.0.1:32910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-n4m8m\" "} {"level":"warn","ts":"2026-06-28T19:57:07.322224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.290617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:07.322259Z","caller":"traceutil/trace.go:171","msg":"trace[1539379548] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:627; }","duration":"707.339349ms","start":"2026-06-28T19:57:06.614909Z","end":"2026-06-28T19:57:07.322248Z","steps":["trace[1539379548] 'agreement among raft nodes before linearized reading' (duration: 707.294317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:07.322285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:06.614893Z","time spent":"707.38619ms","remote":"127.0.0.1:32950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-06-28T19:57:07.322452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"635.6635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:07.322486Z","caller":"traceutil/trace.go:171","msg":"trace[1997461901] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"635.721432ms","start":"2026-06-28T19:57:06.686757Z","end":"2026-06-28T19:57:07.322478Z","steps":["trace[1997461901] 'agreement among raft nodes before linearized reading' (duration: 635.674241ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:07.322512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:06.686743Z","time spent":"635.762644ms","remote":"127.0.0.1:60952","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-28T19:57:07.322553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.797699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-28T19:57:07.322621Z","caller":"traceutil/trace.go:171","msg":"trace[325083345] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:627; }","duration":"434.983505ms","start":"2026-06-28T19:57:06.887621Z","end":"2026-06-28T19:57:07.322605Z","steps":["trace[325083345] 'agreement among raft nodes before linearized reading' (duration: 434.801539ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:07.322654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:06.887607Z","time spent":"435.042246ms","remote":"127.0.0.1:32984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-28T19:57:07.322818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.152159ms","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-28T19:57:07.322838Z","caller":"traceutil/trace.go:171","msg":"trace[1997504608] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:627; }","duration":"309.19412ms","start":"2026-06-28T19:57:07.013638Z","end":"2026-06-28T19:57:07.322833Z","steps":["trace[1997504608] 'agreement among raft nodes before linearized reading' (duration: 309.136008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:07.322857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:07.013626Z","time spent":"309.227491ms","remote":"127.0.0.1:32984","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-28T19:57:08.185482Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276103351292960085,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:57:08.432546Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.06078415s","expected-duration":"1s"} {"level":"info","ts":"2026-06-28T19:57:08.433074Z","caller":"traceutil/trace.go:171","msg":"trace[2010101356] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"1.087788073s","start":"2026-06-28T19:57:07.345261Z","end":"2026-06-28T19:57:08.43305Z","steps":["trace[2010101356] 'process raft request' (duration: 1.087616737s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:08.433215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:07.345239Z","time spent":"1.087903637s","remote":"127.0.0.1:32910","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-28T19:57:08.562714Z","caller":"traceutil/trace.go:171","msg":"trace[1634361861] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:652; }","duration":"877.477459ms","start":"2026-06-28T19:57:07.685207Z","end":"2026-06-28T19:57:08.562685Z","steps":["trace[1634361861] 'read index received' (duration: 747.712066ms)","trace[1634361861] 'applied index is now lower than readState.Index' (duration: 129.764523ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:08.562952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"877.719726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:08.563066Z","caller":"traceutil/trace.go:171","msg":"trace[469212832] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"877.84493ms","start":"2026-06-28T19:57:07.685174Z","end":"2026-06-28T19:57:08.563019Z","steps":["trace[469212832] 'agreement among raft nodes before linearized reading' (duration: 877.699716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:08.563119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:07.685158Z","time spent":"877.953914ms","remote":"127.0.0.1:60936","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-28T19:57:08.563332Z","caller":"traceutil/trace.go:171","msg":"trace[910683129] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"847.588495ms","start":"2026-06-28T19:57:07.71573Z","end":"2026-06-28T19:57:08.563319Z","steps":["trace[910683129] 'process raft request' (duration: 846.469959ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:08.56342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:07.715693Z","time spent":"847.682278ms","remote":"127.0.0.1:32830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:57:08.563748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.188757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-28T19:57:08.563819Z","caller":"traceutil/trace.go:171","msg":"trace[2117868752] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:1; response_revision:631; }","duration":"620.291821ms","start":"2026-06-28T19:57:07.943519Z","end":"2026-06-28T19:57:08.56381Z","steps":["trace[2117868752] 'agreement among raft nodes before linearized reading' (duration: 620.193198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:08.563864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:07.943497Z","time spent":"620.355532ms","remote":"127.0.0.1:60996","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.129\" "} {"level":"warn","ts":"2026-06-28T19:57:08.564045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.446446ms","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-28T19:57:08.564092Z","caller":"traceutil/trace.go:171","msg":"trace[830123837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:631; }","duration":"444.53301ms","start":"2026-06-28T19:57:08.119553Z","end":"2026-06-28T19:57:08.564086Z","steps":["trace[830123837] 'agreement among raft nodes before linearized reading' (duration: 444.423986ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:08.564127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:08.119525Z","time spent":"444.596132ms","remote":"127.0.0.1:32984","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-28T19:57:22.622492Z","caller":"traceutil/trace.go:171","msg":"trace[1582665102] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"892.145517ms","start":"2026-06-28T19:57:21.729755Z","end":"2026-06-28T19:57:22.621901Z","steps":["trace[1582665102] 'process raft request' (duration: 891.992642ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:22.622645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:21.72973Z","time spent":"892.836919ms","remote":"127.0.0.1:32910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:57:50.860692Z","caller":"traceutil/trace.go:171","msg":"trace[1948161549] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"100.082815ms","start":"2026-06-28T19:57:50.760584Z","end":"2026-06-28T19:57:50.860667Z","steps":["trace[1948161549] 'process raft request' (duration: 99.932341ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:57.382431Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276103351292960860,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-28T19:57:57.698564Z","caller":"traceutil/trace.go:171","msg":"trace[953293743] linearizableReadLoop","detail":"{readStateIndex:1040; appliedIndex:1039; }","duration":"816.92924ms","start":"2026-06-28T19:57:56.881604Z","end":"2026-06-28T19:57:57.698533Z","steps":["trace[953293743] 'read index received' (duration: 816.660061ms)","trace[953293743] 'applied index is now lower than readState.Index' (duration: 268.039µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:57.698673Z","caller":"traceutil/trace.go:171","msg":"trace[1555278416] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"819.588055ms","start":"2026-06-28T19:57:56.879052Z","end":"2026-06-28T19:57:57.69864Z","steps":["trace[1555278416] 'process raft request' (duration: 819.299136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:57.698843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"817.212419ms","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-28T19:57:57.698846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:56.879036Z","time spent":"819.724509ms","remote":"127.0.0.1:32984","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-28T19:57:57.698891Z","caller":"traceutil/trace.go:171","msg":"trace[1357345579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1005; }","duration":"817.296662ms","start":"2026-06-28T19:57:56.88158Z","end":"2026-06-28T19:57:57.698876Z","steps":["trace[1357345579] 'agreement among raft nodes before linearized reading' (duration: 817.121356ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:57.69894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:56.881572Z","time spent":"817.353924ms","remote":"127.0.0.1:32984","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-28T19:57:57.699047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.3244ms","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-28T19:57:57.699133Z","caller":"traceutil/trace.go:171","msg":"trace[1154847706] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1005; }","duration":"139.449483ms","start":"2026-06-28T19:57:57.559658Z","end":"2026-06-28T19:57:57.699107Z","steps":["trace[1154847706] 'agreement among raft nodes before linearized reading' (duration: 139.238977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:57.699194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.977142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-28T19:57:57.699235Z","caller":"traceutil/trace.go:171","msg":"trace[914444428] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1005; }","duration":"106.038424ms","start":"2026-06-28T19:57:57.593184Z","end":"2026-06-28T19:57:57.699222Z","steps":["trace[914444428] 'agreement among raft nodes before linearized reading' (duration: 105.89925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:57.699355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.02289ms","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-28T19:57:57.6994Z","caller":"traceutil/trace.go:171","msg":"trace[790532966] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1005; }","duration":"139.105132ms","start":"2026-06-28T19:57:57.560281Z","end":"2026-06-28T19:57:57.699387Z","steps":["trace[790532966] 'agreement among raft nodes before linearized reading' (duration: 138.981278ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:58.60581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.265117ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:57:58.605902Z","caller":"traceutil/trace.go:171","msg":"trace[848094027] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"901.402703ms","start":"2026-06-28T19:57:57.704483Z","end":"2026-06-28T19:57:58.605886Z","steps":["trace[848094027] 'process raft request' (duration: 438.983591ms)","trace[848094027] 'compare' (duration: 462.161543ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:58.605959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:57.704466Z","time spent":"901.467505ms","remote":"127.0.0.1:32984","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-28T19:57:58.608392Z","caller":"traceutil/trace.go:171","msg":"trace[1277377575] linearizableReadLoop","detail":"{readStateIndex:1044; appliedIndex:1040; }","duration":"726.99304ms","start":"2026-06-28T19:57:57.881372Z","end":"2026-06-28T19:57:58.608365Z","steps":["trace[1277377575] 'read index received' (duration: 262.110679ms)","trace[1277377575] 'applied index is now lower than readState.Index' (duration: 464.881341ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:58.608678Z","caller":"traceutil/trace.go:171","msg":"trace[1086306259] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"904.089879ms","start":"2026-06-28T19:57:57.704579Z","end":"2026-06-28T19:57:58.608669Z","steps":["trace[1086306259] 'process raft request' (duration: 903.334175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:58.608769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:57.704566Z","time spent":"904.137481ms","remote":"127.0.0.1:32984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:57:58.608899Z","caller":"traceutil/trace.go:171","msg":"trace[1188118417] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"904.299026ms","start":"2026-06-28T19:57:57.704593Z","end":"2026-06-28T19:57:58.608892Z","steps":["trace[1188118417] 'process raft request' (duration: 903.663486ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:58.608939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:57.704579Z","time spent":"904.341357ms","remote":"127.0.0.1:32984","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-28T19:57:58.609091Z","caller":"traceutil/trace.go:171","msg":"trace[1663285390] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"904.381429ms","start":"2026-06-28T19:57:57.704662Z","end":"2026-06-28T19:57:58.609043Z","steps":["trace[1663285390] 'process raft request' (duration: 903.633385ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:58.609126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:57.704647Z","time spent":"904.459671ms","remote":"127.0.0.1:32984","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-28T19:57:58.609213Z","caller":"traceutil/trace.go:171","msg":"trace[1140467706] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"496.183533ms","start":"2026-06-28T19:57:58.113024Z","end":"2026-06-28T19:57:58.609208Z","steps":["trace[1140467706] 'process raft request' (duration: 495.303135ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:58.609257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:58.113005Z","time spent":"496.228115ms","remote":"127.0.0.1:32984","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-28T19:57:58.609416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.041443ms","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-28T19:57:58.609461Z","caller":"traceutil/trace.go:171","msg":"trace[160358736] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1010; }","duration":"728.100055ms","start":"2026-06-28T19:57:57.88134Z","end":"2026-06-28T19:57:58.60944Z","steps":["trace[160358736] 'agreement among raft nodes before linearized reading' (duration: 728.009943ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:58.609487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:57.881324Z","time spent":"728.157878ms","remote":"127.0.0.1:32984","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-28T19:57:58.609619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.067397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-28T19:57:58.609643Z","caller":"traceutil/trace.go:171","msg":"trace[161056503] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:1; response_revision:1010; }","duration":"664.124869ms","start":"2026-06-28T19:57:57.945512Z","end":"2026-06-28T19:57:58.609637Z","steps":["trace[161056503] 'agreement among raft nodes before linearized reading' (duration: 664.063327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:58.60966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:57:57.945494Z","time spent":"664.16145ms","remote":"127.0.0.1:60996","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.129\" "} {"level":"info","ts":"2026-06-28T19:57:58.802049Z","caller":"traceutil/trace.go:171","msg":"trace[1118157837] linearizableReadLoop","detail":"{readStateIndex:1047; appliedIndex:1045; }","duration":"115.054132ms","start":"2026-06-28T19:57:58.686978Z","end":"2026-06-28T19:57:58.802032Z","steps":["trace[1118157837] 'read index received' (duration: 113.035618ms)","trace[1118157837] 'applied index is now lower than readState.Index' (duration: 2.017944ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:57:58.80215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.153826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:58.802127Z","caller":"traceutil/trace.go:171","msg":"trace[917712044] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"188.778043ms","start":"2026-06-28T19:57:58.613319Z","end":"2026-06-28T19:57:58.802097Z","steps":["trace[917712044] 'process raft request' (duration: 188.644229ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:58.802173Z","caller":"traceutil/trace.go:171","msg":"trace[1008846878] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1011; }","duration":"115.228749ms","start":"2026-06-28T19:57:58.686937Z","end":"2026-06-28T19:57:58.802166Z","steps":["trace[1008846878] 'agreement among raft nodes before linearized reading' (duration: 115.173977ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:20.820544Z","caller":"traceutil/trace.go:171","msg":"trace[1272483000] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1118; }","duration":"102.911584ms","start":"2026-06-28T19:58:20.717607Z","end":"2026-06-28T19:58:20.820518Z","steps":["trace[1272483000] 'read index received' (duration: 102.685317ms)","trace[1272483000] 'applied index is now lower than readState.Index' (duration: 225.347µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:20.820585Z","caller":"traceutil/trace.go:171","msg":"trace[352408150] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"938.610295ms","start":"2026-06-28T19:58:19.881954Z","end":"2026-06-28T19:58:20.820564Z","steps":["trace[352408150] 'process raft request' (duration: 938.438429ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:20.820709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:19.88193Z","time spent":"938.711958ms","remote":"127.0.0.1:32984","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-28T19:58:20.82109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.475092ms","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-28T19:58:20.821158Z","caller":"traceutil/trace.go:171","msg":"trace[1540578872] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1079; }","duration":"103.582825ms","start":"2026-06-28T19:58:20.717557Z","end":"2026-06-28T19:58:20.82114Z","steps":["trace[1540578872] 'agreement among raft nodes before linearized reading' (duration: 103.1033ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:20.993219Z","caller":"traceutil/trace.go:171","msg":"trace[1306253484] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"167.952637ms","start":"2026-06-28T19:58:20.825239Z","end":"2026-06-28T19:58:20.993192Z","steps":["trace[1306253484] 'process raft request' (duration: 83.350079ms)","trace[1306253484] 'compare' (duration: 84.457443ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:20.993567Z","caller":"traceutil/trace.go:171","msg":"trace[353799435] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"167.599075ms","start":"2026-06-28T19:58:20.825939Z","end":"2026-06-28T19:58:20.993539Z","steps":["trace[353799435] 'process raft request' (duration: 167.44707ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:20.993576Z","caller":"traceutil/trace.go:171","msg":"trace[669942922] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"167.233633ms","start":"2026-06-28T19:58:20.826318Z","end":"2026-06-28T19:58:20.993551Z","steps":["trace[669942922] 'process raft request' (duration: 167.14539ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:20.993792Z","caller":"traceutil/trace.go:171","msg":"trace[1610996296] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"167.884955ms","start":"2026-06-28T19:58:20.825863Z","end":"2026-06-28T19:58:20.993748Z","steps":["trace[1610996296] 'process raft request' (duration: 167.296726ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:21.160854Z","caller":"traceutil/trace.go:171","msg":"trace[1086946047] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"160.327133ms","start":"2026-06-28T19:58:21.00049Z","end":"2026-06-28T19:58:21.160817Z","steps":["trace[1086946047] 'process raft request' (duration: 93.68632ms)","trace[1086946047] 'compare' (duration: 66.495488ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:22.361685Z","caller":"traceutil/trace.go:171","msg":"trace[1952653539] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"326.027876ms","start":"2026-06-28T19:58:22.035633Z","end":"2026-06-28T19:58:22.36166Z","steps":["trace[1952653539] 'process raft request' (duration: 325.886592ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:22.362029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:22.035614Z","time spent":"326.234933ms","remote":"127.0.0.1:32984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:58:23.536263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.85048ms","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-28T19:58:23.536416Z","caller":"traceutil/trace.go:171","msg":"trace[98640308] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1091; }","duration":"122.024186ms","start":"2026-06-28T19:58:23.414373Z","end":"2026-06-28T19:58:23.536397Z","steps":["trace[98640308] 'range keys from in-memory index tree' (duration: 121.83164ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:39.220066Z","caller":"traceutil/trace.go:171","msg":"trace[391283765] linearizableReadLoop","detail":"{readStateIndex:1235; appliedIndex:1234; }","duration":"129.268387ms","start":"2026-06-28T19:58:39.090769Z","end":"2026-06-28T19:58:39.220038Z","steps":["trace[391283765] 'read index received' (duration: 129.096302ms)","trace[391283765] 'applied index is now lower than readState.Index' (duration: 170.925µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:39.220101Z","caller":"traceutil/trace.go:171","msg":"trace[1610111469] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"268.208316ms","start":"2026-06-28T19:58:38.951871Z","end":"2026-06-28T19:58:39.22008Z","steps":["trace[1610111469] 'process raft request' (duration: 268.008969ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:39.220342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.219188ms","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-28T19:58:39.220392Z","caller":"traceutil/trace.go:171","msg":"trace[654081923] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1189; }","duration":"125.322711ms","start":"2026-06-28T19:58:39.095054Z","end":"2026-06-28T19:58:39.220377Z","steps":["trace[654081923] 'agreement among raft nodes before linearized reading' (duration: 125.141825ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:39.220432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.64476ms","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-28T19:58:39.220496Z","caller":"traceutil/trace.go:171","msg":"trace[236838819] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1189; }","duration":"129.747844ms","start":"2026-06-28T19:58:39.090733Z","end":"2026-06-28T19:58:39.220481Z","steps":["trace[236838819] 'agreement among raft nodes before linearized reading' (duration: 129.452204ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:53.010207Z","caller":"traceutil/trace.go:171","msg":"trace[624545499] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"130.498568ms","start":"2026-06-28T19:58:52.879676Z","end":"2026-06-28T19:58:53.010175Z","steps":["trace[624545499] 'process raft request' (duration: 130.386684ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:58.520831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.301547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-28T19:58:58.520972Z","caller":"traceutil/trace.go:171","msg":"trace[809751177] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1274; }","duration":"302.509534ms","start":"2026-06-28T19:58:58.218439Z","end":"2026-06-28T19:58:58.520948Z","steps":["trace[809751177] 'count revisions from in-memory index tree' (duration: 302.208794ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:58.521051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:58.218413Z","time spent":"302.625748ms","remote":"127.0.0.1:33084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":29,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:58:59.920337Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276103351292961519,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:59:00.420995Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276103351292961519,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-28T19:59:00.648591Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.261578005s","expected-duration":"1s"} {"level":"info","ts":"2026-06-28T19:59:00.649034Z","caller":"traceutil/trace.go:171","msg":"trace[632571689] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"1.262091182s","start":"2026-06-28T19:58:59.386911Z","end":"2026-06-28T19:59:00.649002Z","steps":["trace[632571689] 'process raft request' (duration: 1.261887895s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:00.64919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:59.386893Z","time spent":"1.262205136s","remote":"127.0.0.1:32984","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-28T19:59:00.985819Z","caller":"traceutil/trace.go:171","msg":"trace[457165793] linearizableReadLoop","detail":"{readStateIndex:1333; appliedIndex:1332; }","duration":"1.565889807s","start":"2026-06-28T19:58:59.419904Z","end":"2026-06-28T19:59:00.985793Z","steps":["trace[457165793] 'read index received' (duration: 1.229061154s)","trace[457165793] 'applied index is now lower than readState.Index' (duration: 336.827533ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:59:00.986133Z","caller":"traceutil/trace.go:171","msg":"trace[292317883] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"1.253388674s","start":"2026-06-28T19:58:59.732718Z","end":"2026-06-28T19:59:00.986106Z","steps":["trace[292317883] 'process raft request' (duration: 1.161801182s)","trace[292317883] 'compare' (duration: 91.155328ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:59:00.986254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:59.732687Z","time spent":"1.253502418s","remote":"127.0.0.1:32984","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-28T19:59:00.986248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.566322861s","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-28T19:59:00.986313Z","caller":"traceutil/trace.go:171","msg":"trace[527098441] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1283; }","duration":"1.566437235s","start":"2026-06-28T19:58:59.419861Z","end":"2026-06-28T19:59:00.986299Z","steps":["trace[527098441] 'agreement among raft nodes before linearized reading' (duration: 1.56626543s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:00.986324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.557190869s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-28T19:59:00.986366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:59.419843Z","time spent":"1.566503067s","remote":"127.0.0.1:32984","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-28T19:59:00.986381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.773366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-28T19:59:00.986417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.543360246s","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-28T19:59:00.986388Z","caller":"traceutil/trace.go:171","msg":"trace[1279791319] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1283; }","duration":"1.557294222s","start":"2026-06-28T19:58:59.429077Z","end":"2026-06-28T19:59:00.986371Z","steps":["trace[1279791319] 'agreement among raft nodes before linearized reading' (duration: 1.557098196s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:00.986455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.280471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:59:00.98646Z","caller":"traceutil/trace.go:171","msg":"trace[1328446655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1283; }","duration":"299.88843ms","start":"2026-06-28T19:59:00.686555Z","end":"2026-06-28T19:59:00.986443Z","steps":["trace[1328446655] 'agreement among raft nodes before linearized reading' (duration: 299.755686ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:00.986471Z","caller":"traceutil/trace.go:171","msg":"trace[1741910439] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1283; }","duration":"1.543540572s","start":"2026-06-28T19:58:59.442918Z","end":"2026-06-28T19:59:00.986459Z","steps":["trace[1741910439] 'agreement among raft nodes before linearized reading' (duration: 1.543348306s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:00.986372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.543228102s","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-28T19:59:00.986505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:59.442907Z","time spent":"1.543593344s","remote":"127.0.0.1:32984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-28T19:59:00.9865Z","caller":"traceutil/trace.go:171","msg":"trace[1935354195] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1283; }","duration":"483.364144ms","start":"2026-06-28T19:59:00.503122Z","end":"2026-06-28T19:59:00.986486Z","steps":["trace[1935354195] 'agreement among raft nodes before linearized reading' (duration: 483.286812ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:00.98652Z","caller":"traceutil/trace.go:171","msg":"trace[1340511665] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1283; }","duration":"1.543407988s","start":"2026-06-28T19:58:59.443099Z","end":"2026-06-28T19:59:00.986507Z","steps":["trace[1340511665] 'agreement among raft nodes before linearized reading' (duration: 1.54315237s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:00.986538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:00.503106Z","time spent":"483.423806ms","remote":"127.0.0.1:32862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":27,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:59:00.986554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:59.443082Z","time spent":"1.543463159s","remote":"127.0.0.1:32984","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-28T19:59:00.986496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:59.429061Z","time spent":"1.557420786s","remote":"127.0.0.1:32984","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-28T19:59:00.986589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.554585225s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-28T19:59:00.986621Z","caller":"traceutil/trace.go:171","msg":"trace[672142823] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1283; }","duration":"1.554638907s","start":"2026-06-28T19:58:59.431971Z","end":"2026-06-28T19:59:00.98661Z","steps":["trace[672142823] 'agreement among raft nodes before linearized reading' (duration: 1.554551164s)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:00.986652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:59.431958Z","time spent":"1.554687598s","remote":"127.0.0.1:32984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-28T19:59:01.325425Z","caller":"traceutil/trace.go:171","msg":"trace[962866763] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"335.428577ms","start":"2026-06-28T19:59:00.989972Z","end":"2026-06-28T19:59:01.325401Z","steps":["trace[962866763] 'process raft request' (duration: 335.127508ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:01.325567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:00.989955Z","time spent":"335.538291ms","remote":"127.0.0.1:32984","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-28T19:59:01.325766Z","caller":"traceutil/trace.go:171","msg":"trace[1322878901] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"335.412007ms","start":"2026-06-28T19:59:00.990323Z","end":"2026-06-28T19:59:01.325735Z","steps":["trace[1322878901] 'process raft request' (duration: 335.018565ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:01.325837Z","caller":"traceutil/trace.go:171","msg":"trace[1897719913] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"335.1739ms","start":"2026-06-28T19:59:00.990634Z","end":"2026-06-28T19:59:01.325808Z","steps":["trace[1897719913] 'process raft request' (duration: 334.963013ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:01.325832Z","caller":"traceutil/trace.go:171","msg":"trace[1892861605] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"334.88902ms","start":"2026-06-28T19:59:00.990914Z","end":"2026-06-28T19:59:01.325803Z","steps":["trace[1892861605] 'process raft request' (duration: 334.820228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:01.325951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:00.990616Z","time spent":"335.274103ms","remote":"127.0.0.1:32984","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-28T19:59:01.32599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:00.990904Z","time spent":"335.001524ms","remote":"127.0.0.1:32984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:59:01.326059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:00.990297Z","time spent":"335.536361ms","remote":"127.0.0.1:32984","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-28T19:59:02.789556Z","caller":"traceutil/trace.go:171","msg":"trace[1137589354] linearizableReadLoop","detail":"{readStateIndex:1339; appliedIndex:1338; }","duration":"104.198016ms","start":"2026-06-28T19:59:02.685336Z","end":"2026-06-28T19:59:02.789534Z","steps":["trace[1137589354] 'read index received' (duration: 104.079022ms)","trace[1137589354] 'applied index is now lower than readState.Index' (duration: 117.934µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:59:02.789618Z","caller":"traceutil/trace.go:171","msg":"trace[1774653721] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"127.742659ms","start":"2026-06-28T19:59:02.66184Z","end":"2026-06-28T19:59:02.789583Z","steps":["trace[1774653721] 'process raft request' (duration: 127.567084ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:02.789673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.304499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:59:02.789698Z","caller":"traceutil/trace.go:171","msg":"trace[430939412] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1289; }","duration":"104.389962ms","start":"2026-06-28T19:59:02.6853Z","end":"2026-06-28T19:59:02.78969Z","steps":["trace[430939412] 'agreement among raft nodes before linearized reading' (duration: 104.316759ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:03.238601Z","caller":"traceutil/trace.go:171","msg":"trace[1271787139] linearizableReadLoop","detail":"{readStateIndex:1340; appliedIndex:1339; }","duration":"448.005451ms","start":"2026-06-28T19:59:02.790572Z","end":"2026-06-28T19:59:03.238578Z","steps":["trace[1271787139] 'read index received' (duration: 447.726053ms)","trace[1271787139] 'applied index is now lower than readState.Index' (duration: 278.528µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:59:03.238918Z","caller":"traceutil/trace.go:171","msg":"trace[841528938] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"546.187124ms","start":"2026-06-28T19:59:02.692719Z","end":"2026-06-28T19:59:03.238906Z","steps":["trace[841528938] 'process raft request' (duration: 545.686838ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:03.239016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:02.692691Z","time spent":"546.256586ms","remote":"127.0.0.1:32908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6105,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:59:03.239175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.59921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:59:03.239205Z","caller":"traceutil/trace.go:171","msg":"trace[1097261149] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1290; }","duration":"448.656672ms","start":"2026-06-28T19:59:02.790538Z","end":"2026-06-28T19:59:03.239195Z","steps":["trace[1097261149] 'agreement among raft nodes before linearized reading' (duration: 448.608651ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:03.239231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:02.790524Z","time spent":"448.701424ms","remote":"127.0.0.1:60952","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-28T19:59:03.239287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.170835ms","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-28T19:59:03.239377Z","caller":"traceutil/trace.go:171","msg":"trace[743751070] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1290; }","duration":"189.335751ms","start":"2026-06-28T19:59:03.050017Z","end":"2026-06-28T19:59:03.239353Z","steps":["trace[743751070] 'agreement among raft nodes before linearized reading' (duration: 189.052062ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:07.522295Z","caller":"traceutil/trace.go:171","msg":"trace[1730268941] linearizableReadLoop","detail":"{readStateIndex:1370; appliedIndex:1369; }","duration":"173.834524ms","start":"2026-06-28T19:59:07.348437Z","end":"2026-06-28T19:59:07.522271Z","steps":["trace[1730268941] 'read index received' (duration: 173.656028ms)","trace[1730268941] 'applied index is now lower than readState.Index' (duration: 177.216µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:59:07.522397Z","caller":"traceutil/trace.go:171","msg":"trace[813717758] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"220.736456ms","start":"2026-06-28T19:59:07.301643Z","end":"2026-06-28T19:59:07.522379Z","steps":["trace[813717758] 'process raft request' (duration: 220.496018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:07.522539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.572474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-28T19:59:07.522591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.627724ms","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-28T19:59:07.522613Z","caller":"traceutil/trace.go:171","msg":"trace[712770572] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1319; }","duration":"172.692748ms","start":"2026-06-28T19:59:07.349907Z","end":"2026-06-28T19:59:07.5226Z","steps":["trace[712770572] 'agreement among raft nodes before linearized reading' (duration: 172.502862ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:07.522655Z","caller":"traceutil/trace.go:171","msg":"trace[1564170185] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1319; }","duration":"171.760248ms","start":"2026-06-28T19:59:07.350876Z","end":"2026-06-28T19:59:07.522636Z","steps":["trace[1564170185] 'agreement among raft nodes before linearized reading' (duration: 171.595793ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:07.522834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.399002ms","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-28T19:59:07.522862Z","caller":"traceutil/trace.go:171","msg":"trace[1936785521] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1319; }","duration":"174.480725ms","start":"2026-06-28T19:59:07.348375Z","end":"2026-06-28T19:59:07.522856Z","steps":["trace[1936785521] 'agreement among raft nodes before linearized reading' (duration: 174.402502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:07.523047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.639224ms","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-28T19:59:07.523691Z","caller":"traceutil/trace.go:171","msg":"trace[794868080] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1319; }","duration":"172.020146ms","start":"2026-06-28T19:59:07.351344Z","end":"2026-06-28T19:59:07.523364Z","steps":["trace[794868080] 'agreement among raft nodes before linearized reading' (duration: 171.079136ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:07.663109Z","caller":"traceutil/trace.go:171","msg":"trace[1510546917] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"136.384286ms","start":"2026-06-28T19:59:07.526699Z","end":"2026-06-28T19:59:07.663084Z","steps":["trace[1510546917] 'process raft request' (duration: 136.19889ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:07.663431Z","caller":"traceutil/trace.go:171","msg":"trace[1051762410] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"136.5076ms","start":"2026-06-28T19:59:07.526896Z","end":"2026-06-28T19:59:07.663404Z","steps":["trace[1051762410] 'process raft request' (duration: 136.394116ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:07.663455Z","caller":"traceutil/trace.go:171","msg":"trace[599272047] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"136.576212ms","start":"2026-06-28T19:59:07.526848Z","end":"2026-06-28T19:59:07.663424Z","steps":["trace[599272047] 'process raft request' (duration: 136.193309ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:09.812003Z","caller":"traceutil/trace.go:171","msg":"trace[378840420] linearizableReadLoop","detail":"{readStateIndex:1398; appliedIndex:1397; }","duration":"286.038424ms","start":"2026-06-28T19:59:09.525946Z","end":"2026-06-28T19:59:09.811984Z","steps":["trace[378840420] 'read index received' (duration: 285.888729ms)","trace[378840420] 'applied index is now lower than readState.Index' (duration: 149.015µs)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:59:09.812108Z","caller":"traceutil/trace.go:171","msg":"trace[1159418969] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"432.891544ms","start":"2026-06-28T19:59:09.379183Z","end":"2026-06-28T19:59:09.812074Z","steps":["trace[1159418969] 'process raft request' (duration: 432.674877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:09.812163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.20974ms","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-28T19:59:09.812208Z","caller":"traceutil/trace.go:171","msg":"trace[953646625] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1346; }","duration":"286.297503ms","start":"2026-06-28T19:59:09.525904Z","end":"2026-06-28T19:59:09.812201Z","steps":["trace[953646625] 'agreement among raft nodes before linearized reading' (duration: 286.170269ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:09.812243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.743453ms","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-28T19:59:09.812273Z","caller":"traceutil/trace.go:171","msg":"trace[365222549] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1346; }","duration":"144.824235ms","start":"2026-06-28T19:59:09.667441Z","end":"2026-06-28T19:59:09.812266Z","steps":["trace[365222549] 'agreement among raft nodes before linearized reading' (duration: 144.716982ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:09.812303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:09.379159Z","time spent":"433.058659ms","remote":"127.0.0.1:32984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":458,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:59:09.812318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.610195ms","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-28T19:59:09.812333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.911608ms","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-28T19:59:09.812377Z","caller":"traceutil/trace.go:171","msg":"trace[1204729496] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1346; }","duration":"142.688497ms","start":"2026-06-28T19:59:09.669675Z","end":"2026-06-28T19:59:09.812364Z","steps":["trace[1204729496] 'agreement among raft nodes before linearized reading' (duration: 142.511381ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:09.812391Z","caller":"traceutil/trace.go:171","msg":"trace[58010582] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1346; }","duration":"145.014942ms","start":"2026-06-28T19:59:09.667363Z","end":"2026-06-28T19:59:09.812378Z","steps":["trace[58010582] 'agreement among raft nodes before linearized reading' (duration: 144.794124ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:09.812533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.118071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-28T19:59:09.812653Z","caller":"traceutil/trace.go:171","msg":"trace[1406741391] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1346; }","duration":"198.205334ms","start":"2026-06-28T19:59:09.614375Z","end":"2026-06-28T19:59:09.81258Z","steps":["trace[1406741391] 'agreement among raft nodes before linearized reading' (duration: 197.741239ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:10.676864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.480906ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:59:10.677133Z","caller":"traceutil/trace.go:171","msg":"trace[1879609412] linearizableReadLoop","detail":"{readStateIndex:1403; appliedIndex:1398; }","duration":"261.923934ms","start":"2026-06-28T19:59:10.415193Z","end":"2026-06-28T19:59:10.677117Z","steps":["trace[1879609412] 'read index received' (duration: 72.143929ms)","trace[1879609412] 'applied index is now lower than readState.Index' (duration: 189.779085ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:59:10.677283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.08709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-28T19:59:10.677314Z","caller":"traceutil/trace.go:171","msg":"trace[1771275703] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1351; }","duration":"262.145812ms","start":"2026-06-28T19:59:10.415159Z","end":"2026-06-28T19:59:10.677305Z","steps":["trace[1771275703] 'agreement among raft nodes before linearized reading' (duration: 262.007168ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:10.677412Z","caller":"traceutil/trace.go:171","msg":"trace[1555148652] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"860.483677ms","start":"2026-06-28T19:59:09.816917Z","end":"2026-06-28T19:59:10.677401Z","steps":["trace[1555148652] 'process raft request' (duration: 670.405763ms)","trace[1555148652] 'compare' (duration: 189.33002ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:59:10.677465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:09.816892Z","time spent":"860.543979ms","remote":"127.0.0.1:32984","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-28T19:59:10.677532Z","caller":"traceutil/trace.go:171","msg":"trace[1013581590] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"859.00754ms","start":"2026-06-28T19:59:09.818495Z","end":"2026-06-28T19:59:10.677503Z","steps":["trace[1013581590] 'process raft request' (duration: 858.511364ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:10.677586Z","caller":"traceutil/trace.go:171","msg":"trace[1298265529] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"860.634092ms","start":"2026-06-28T19:59:09.816932Z","end":"2026-06-28T19:59:10.677566Z","steps":["trace[1298265529] 'process raft request' (duration: 860.006332ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:10.677594Z","caller":"traceutil/trace.go:171","msg":"trace[43400074] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"858.916427ms","start":"2026-06-28T19:59:09.818663Z","end":"2026-06-28T19:59:10.677579Z","steps":["trace[43400074] 'process raft request' (duration: 858.416801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:10.677676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:09.818487Z","time spent":"859.113113ms","remote":"127.0.0.1:32984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:59:10.677695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:09.816912Z","time spent":"860.716025ms","remote":"127.0.0.1:32984","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-28T19:59:10.67776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:09.818659Z","time spent":"858.99708ms","remote":"127.0.0.1:32984","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-28T19:59:10.678072Z","caller":"traceutil/trace.go:171","msg":"trace[169435825] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"858.892656ms","start":"2026-06-28T19:59:09.818635Z","end":"2026-06-28T19:59:10.677528Z","steps":["trace[169435825] 'process raft request' (duration: 858.414771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:59:10.678124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:59:09.818629Z","time spent":"859.470374ms","remote":"127.0.0.1:32984","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-28T19:59:26.909523Z","caller":"traceutil/trace.go:171","msg":"trace[958192529] transaction","detail":"{read_only:false; response_revision:1425; number_of_response:1; }","duration":"112.791071ms","start":"2026-06-28T19:59:26.796712Z","end":"2026-06-28T19:59:26.909504Z","steps":["trace[958192529] 'process raft request' (duration: 112.677117ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:26.909509Z","caller":"traceutil/trace.go:171","msg":"trace[1039173053] transaction","detail":"{read_only:false; response_revision:1424; number_of_response:1; }","duration":"113.576546ms","start":"2026-06-28T19:59:26.795901Z","end":"2026-06-28T19:59:26.909477Z","steps":["trace[1039173053] 'process raft request' (duration: 76.242151ms)","trace[1039173053] 'compare' (duration: 37.110178ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:59:26.909777Z","caller":"traceutil/trace.go:171","msg":"trace[1507833423] linearizableReadLoop","detail":"{readStateIndex:1480; appliedIndex:1477; }","duration":"102.523382ms","start":"2026-06-28T19:59:26.807236Z","end":"2026-06-28T19:59:26.90976Z","steps":["trace[1507833423] 'read index received' (duration: 22.537942ms)","trace[1507833423] 'applied index is now lower than readState.Index' (duration: 79.98387ms)"],"step_count":2} {"level":"warn","ts":"2026-06-28T19:59:26.909961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.699638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-28T19:59:26.910019Z","caller":"traceutil/trace.go:171","msg":"trace[1807970687] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1426; }","duration":"102.793741ms","start":"2026-06-28T19:59:26.807208Z","end":"2026-06-28T19:59:26.910002Z","steps":["trace[1807970687] 'agreement among raft nodes before linearized reading' (duration: 102.622755ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:02:58.019065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.76068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-28T20:02:58.019167Z","caller":"traceutil/trace.go:171","msg":"trace[1139926439] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2418; }","duration":"160.914845ms","start":"2026-06-28T20:02:57.858229Z","end":"2026-06-28T20:02:58.019144Z","steps":["trace[1139926439] 'range keys from in-memory index tree' (duration: 160.549683ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:02:58.019282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.983637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-28T20:02:58.019361Z","caller":"traceutil/trace.go:171","msg":"trace[1522723671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2418; }","duration":"161.105071ms","start":"2026-06-28T20:02:57.858237Z","end":"2026-06-28T20:02:58.019342Z","steps":["trace[1522723671] 'range keys from in-memory index tree' (duration: 160.847123ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T20:02:58.019284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.517222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-28T20:02:58.019478Z","caller":"traceutil/trace.go:171","msg":"trace[428288466] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2418; }","duration":"165.76633ms","start":"2026-06-28T20:02:57.853703Z","end":"2026-06-28T20:02:58.01947Z","steps":["trace[428288466] 'range keys from in-memory index tree' (duration: 165.387308ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:02:58.172212Z","caller":"traceutil/trace.go:171","msg":"trace[1587657427] transaction","detail":"{read_only:false; response_revision:2419; number_of_response:1; }","duration":"149.813959ms","start":"2026-06-28T20:02:58.022367Z","end":"2026-06-28T20:02:58.172181Z","steps":["trace[1587657427] 'process raft request' (duration: 113.756377ms)","trace[1587657427] 'compare' (duration: 35.819685ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T20:02:58.172558Z","caller":"traceutil/trace.go:171","msg":"trace[647957185] transaction","detail":"{read_only:false; response_revision:2420; number_of_response:1; }","duration":"149.808779ms","start":"2026-06-28T20:02:58.022716Z","end":"2026-06-28T20:02:58.172525Z","steps":["trace[647957185] 'process raft request' (duration: 149.411747ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:02:58.172929Z","caller":"traceutil/trace.go:171","msg":"trace[1668265691] transaction","detail":"{read_only:false; response_revision:2421; number_of_response:1; }","duration":"149.377496ms","start":"2026-06-28T20:02:58.02354Z","end":"2026-06-28T20:02:58.172918Z","steps":["trace[1668265691] 'process raft request' (duration: 148.87579ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T20:02:58.17315Z","caller":"traceutil/trace.go:171","msg":"trace[779107096] transaction","detail":"{read_only:false; response_revision:2422; number_of_response:1; }","duration":"139.692357ms","start":"2026-06-28T20:02:58.03338Z","end":"2026-06-28T20:02:58.173072Z","steps":["trace[779107096] 'process raft request' (duration: 139.496191ms)"],"step_count":1}