{"level":"warn","ts":"2026-05-07T09:12:30.04659Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-07T09:12:30.046691Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.74: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.74:2380","--initial-cluster=instance=https://199.204.45.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.74: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-05-07T09:12:30.046762Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-07T09:12:30.046775Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-05-07T09:12:30.046796Z","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-05-07T09:12:30.047462Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"]} {"level":"info","ts":"2026-05-07T09:12:30.047544Z","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.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.74: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-05-07T09:12:30.184215Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"136.424738ms"} {"level":"info","ts":"2026-05-07T09:12:30.553194Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"89ba38f964b95aa0","cluster-id":"54492f71bf65c400"} {"level":"info","ts":"2026-05-07T09:12:30.553291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=()"} {"level":"info","ts":"2026-05-07T09:12:30.553319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 0"} {"level":"info","ts":"2026-05-07T09:12:30.553334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 89ba38f964b95aa0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-07T09:12:30.553345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 1"} {"level":"info","ts":"2026-05-07T09:12:30.553382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"warn","ts":"2026-05-07T09:12:31.246026Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-07T09:12:31.442387Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-07T09:12:31.595527Z","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-05-07T09:12:31.730539Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"89ba38f964b95aa0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-07T09:12:31.731028Z","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-05-07T09:12:31.731118Z","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-05-07T09:12:31.73113Z","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-05-07T09:12:31.731132Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"89ba38f964b95aa0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-07T09:12:31.734871Z","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-05-07T09:12:31.735005Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-05-07T09:12:31.735059Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-05-07T09:12:31.735235Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"89ba38f964b95aa0","initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-07T09:12:31.735314Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-07T09:12:31.769766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"info","ts":"2026-05-07T09:12:31.770107Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","added-peer-id":"89ba38f964b95aa0","added-peer-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-05-07T09:12:31.954533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 is starting a new election at term 1"} {"level":"info","ts":"2026-05-07T09:12:31.954648Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-07T09:12:31.954716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgPreVoteResp from 89ba38f964b95aa0 at term 1"} {"level":"info","ts":"2026-05-07T09:12:31.954737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became candidate at term 2"} {"level":"info","ts":"2026-05-07T09:12:31.954801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgVoteResp from 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-05-07T09:12:31.954856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became leader at term 2"} {"level":"info","ts":"2026-05-07T09:12:31.954872Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 89ba38f964b95aa0 elected leader 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-05-07T09:12:31.967332Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"89ba38f964b95aa0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.74:2379]}","request-path":"/0/members/89ba38f964b95aa0/attributes","cluster-id":"54492f71bf65c400","publish-timeout":"7s"} {"level":"info","ts":"2026-05-07T09:12:31.967447Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-07T09:12:31.967591Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-07T09:12:31.967823Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-07T09:12:31.967986Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-07T09:12:31.968177Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T09:12:31.970573Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T09:12:31.970816Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T09:12:31.970884Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-07T09:12:31.972145Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-07T09:12:31.972213Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.74:2379"} {"level":"info","ts":"2026-05-07T09:12:33.438407Z","caller":"traceutil/trace.go:171","msg":"trace[2145733] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"149.282613ms","start":"2026-05-07T09:12:33.289099Z","end":"2026-05-07T09:12:33.438382Z","steps":["trace[2145733] 'process raft request' (duration: 149.103812ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.499185Z","caller":"traceutil/trace.go:171","msg":"trace[1738645838] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"128.412846ms","start":"2026-05-07T09:12:33.370716Z","end":"2026-05-07T09:12:33.499129Z","steps":["trace[1738645838] 'process raft request' (duration: 128.262495ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.499259Z","caller":"traceutil/trace.go:171","msg":"trace[305525210] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"200.75483ms","start":"2026-05-07T09:12:33.29848Z","end":"2026-05-07T09:12:33.499235Z","steps":["trace[305525210] 'read index received' (duration: 139.848093ms)","trace[305525210] 'applied index is now lower than readState.Index' (duration: 60.905857ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T09:12:33.499499Z","caller":"traceutil/trace.go:171","msg":"trace[1647326528] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"114.621342ms","start":"2026-05-07T09:12:33.384848Z","end":"2026-05-07T09:12:33.499469Z","steps":["trace[1647326528] 'process raft request' (duration: 114.298669ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.499555Z","caller":"traceutil/trace.go:171","msg":"trace[561551400] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"114.591971ms","start":"2026-05-07T09:12:33.384949Z","end":"2026-05-07T09:12:33.499541Z","steps":["trace[561551400] 'process raft request' (duration: 114.246889ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.499551Z","caller":"traceutil/trace.go:171","msg":"trace[220004839] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"114.643612ms","start":"2026-05-07T09:12:33.384856Z","end":"2026-05-07T09:12:33.4995Z","steps":["trace[220004839] 'process raft request' (duration: 114.31375ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.499616Z","caller":"traceutil/trace.go:171","msg":"trace[1553979004] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"114.794853ms","start":"2026-05-07T09:12:33.384796Z","end":"2026-05-07T09:12:33.49959Z","steps":["trace[1553979004] 'process raft request' (duration: 114.312789ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.499328Z","caller":"traceutil/trace.go:171","msg":"trace[608185907] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"123.031165ms","start":"2026-05-07T09:12:33.376271Z","end":"2026-05-07T09:12:33.499302Z","steps":["trace[608185907] 'process raft request' (duration: 122.748252ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.499799Z","caller":"traceutil/trace.go:171","msg":"trace[56666612] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"114.915484ms","start":"2026-05-07T09:12:33.384624Z","end":"2026-05-07T09:12:33.499539Z","steps":["trace[56666612] 'process raft request' (duration: 114.425011ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:12:33.499948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.451655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-07T09:12:33.500072Z","caller":"traceutil/trace.go:171","msg":"trace[597532448] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"201.623126ms","start":"2026-05-07T09:12:33.298437Z","end":"2026-05-07T09:12:33.50006Z","steps":["trace[597532448] 'agreement among raft nodes before linearized reading' (duration: 201.417195ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:12:33.500117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.281237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.74\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-07T09:12:33.500274Z","caller":"traceutil/trace.go:171","msg":"trace[1596749298] range","detail":"{range_begin:/registry/masterleases/199.204.45.74; range_end:; response_count:0; response_revision:10; }","duration":"131.513549ms","start":"2026-05-07T09:12:33.368746Z","end":"2026-05-07T09:12:33.50026Z","steps":["trace[1596749298] 'agreement among raft nodes before linearized reading' (duration: 131.050555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:12:33.500415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.160172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-07T09:12:33.500428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.418913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-07T09:12:33.500461Z","caller":"traceutil/trace.go:171","msg":"trace[2024387967] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"129.240562ms","start":"2026-05-07T09:12:33.371205Z","end":"2026-05-07T09:12:33.500446Z","steps":["trace[2024387967] 'agreement among raft nodes before linearized reading' (duration: 129.163082ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.50048Z","caller":"traceutil/trace.go:171","msg":"trace[1574472592] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"129.515904ms","start":"2026-05-07T09:12:33.37095Z","end":"2026-05-07T09:12:33.500466Z","steps":["trace[1574472592] 'agreement among raft nodes before linearized reading' (duration: 129.424464ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.5022Z","caller":"traceutil/trace.go:171","msg":"trace[950385062] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"211.529911ms","start":"2026-05-07T09:12:33.290649Z","end":"2026-05-07T09:12:33.502179Z","steps":["trace[950385062] 'process raft request' (duration: 208.156096ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.658734Z","caller":"traceutil/trace.go:171","msg":"trace[1286938207] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"149.983817ms","start":"2026-05-07T09:12:33.508731Z","end":"2026-05-07T09:12:33.658715Z","steps":["trace[1286938207] 'process raft request' (duration: 149.647195ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.658949Z","caller":"traceutil/trace.go:171","msg":"trace[1957865501] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"150.609352ms","start":"2026-05-07T09:12:33.508327Z","end":"2026-05-07T09:12:33.658937Z","steps":["trace[1957865501] 'process raft request' (duration: 149.992297ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.658989Z","caller":"traceutil/trace.go:171","msg":"trace[1248170204] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"151.242397ms","start":"2026-05-07T09:12:33.507721Z","end":"2026-05-07T09:12:33.658964Z","steps":["trace[1248170204] 'process raft request' (duration: 150.494752ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.658997Z","caller":"traceutil/trace.go:171","msg":"trace[794399173] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:13; }","duration":"152.491497ms","start":"2026-05-07T09:12:33.506399Z","end":"2026-05-07T09:12:33.658891Z","steps":["trace[794399173] 'read index received' (duration: 20.718166ms)","trace[794399173] 'applied index is now lower than readState.Index' (duration: 131.770301ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T09:12:33.658735Z","caller":"traceutil/trace.go:171","msg":"trace[1803129476] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"149.994617ms","start":"2026-05-07T09:12:33.508691Z","end":"2026-05-07T09:12:33.658685Z","steps":["trace[1803129476] 'process raft request' (duration: 149.658355ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.659138Z","caller":"traceutil/trace.go:171","msg":"trace[1695576241] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"152.878539ms","start":"2026-05-07T09:12:33.506246Z","end":"2026-05-07T09:12:33.659124Z","steps":["trace[1695576241] 'process raft request' (duration: 81.450092ms)","trace[1695576241] 'compare' (duration: 70.4053ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T09:12:33.659202Z","caller":"traceutil/trace.go:171","msg":"trace[1578740425] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"150.21038ms","start":"2026-05-07T09:12:33.508943Z","end":"2026-05-07T09:12:33.659153Z","steps":["trace[1578740425] 'process raft request' (duration: 149.455694ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:12:33.659368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.94339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-07T09:12:33.659416Z","caller":"traceutil/trace.go:171","msg":"trace[247339190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19; }","duration":"153.05404ms","start":"2026-05-07T09:12:33.506348Z","end":"2026-05-07T09:12:33.659402Z","steps":["trace[247339190] 'agreement among raft nodes before linearized reading' (duration: 152.909519ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.659545Z","caller":"traceutil/trace.go:171","msg":"trace[1425301612] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"141.818316ms","start":"2026-05-07T09:12:33.517715Z","end":"2026-05-07T09:12:33.659534Z","steps":["trace[1425301612] 'process raft request' (duration: 140.712848ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:12:33.659793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.443916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3490"} {"level":"info","ts":"2026-05-07T09:12:33.662123Z","caller":"traceutil/trace.go:171","msg":"trace[759700050] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:19; }","duration":"154.752383ms","start":"2026-05-07T09:12:33.507318Z","end":"2026-05-07T09:12:33.662071Z","steps":["trace[759700050] 'agreement among raft nodes before linearized reading' (duration: 152.324175ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:12:33.659814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.438365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-07T09:12:33.659897Z","caller":"traceutil/trace.go:171","msg":"trace[1896478415] transaction","detail":"{read_only:false; number_of_response:0; response_revision:13; }","duration":"150.679873ms","start":"2026-05-07T09:12:33.508238Z","end":"2026-05-07T09:12:33.658918Z","steps":["trace[1896478415] 'process raft request' (duration: 150.013698ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.663057Z","caller":"traceutil/trace.go:171","msg":"trace[1763621874] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:19; }","duration":"131.71561ms","start":"2026-05-07T09:12:33.531328Z","end":"2026-05-07T09:12:33.663043Z","steps":["trace[1763621874] 'agreement among raft nodes before linearized reading' (duration: 128.451715ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:12:33.863236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.852354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-07T09:12:33.863409Z","caller":"traceutil/trace.go:171","msg":"trace[78871335] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:28; }","duration":"192.042135ms","start":"2026-05-07T09:12:33.671332Z","end":"2026-05-07T09:12:33.863374Z","steps":["trace[78871335] 'agreement among raft nodes before linearized reading' (duration: 86.942144ms)","trace[78871335] 'range keys from in-memory index tree' (duration: 104.688169ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T09:12:33.863549Z","caller":"traceutil/trace.go:171","msg":"trace[678686599] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"159.4729ms","start":"2026-05-07T09:12:33.704038Z","end":"2026-05-07T09:12:33.863511Z","steps":["trace[678686599] 'process raft request' (duration: 110.409091ms)","trace[678686599] 'compare' (duration: 48.601786ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T09:12:33.863681Z","caller":"traceutil/trace.go:171","msg":"trace[1027324205] linearizableReadLoop","detail":"{readStateIndex:34; appliedIndex:32; }","duration":"105.728556ms","start":"2026-05-07T09:12:33.757862Z","end":"2026-05-07T09:12:33.863591Z","steps":["trace[1027324205] 'read index received' (duration: 56.542515ms)","trace[1027324205] 'applied index is now lower than readState.Index' (duration: 49.184541ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T09:12:33.863913Z","caller":"traceutil/trace.go:171","msg":"trace[1145674706] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"159.673191ms","start":"2026-05-07T09:12:33.704227Z","end":"2026-05-07T09:12:33.8639Z","steps":["trace[1145674706] 'process raft request' (duration: 159.113787ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:12:33.864054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.047496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-07T09:12:33.864143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.803453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-07T09:12:33.86423Z","caller":"traceutil/trace.go:171","msg":"trace[1274611882] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:30; }","duration":"155.933353ms","start":"2026-05-07T09:12:33.708275Z","end":"2026-05-07T09:12:33.864208Z","steps":["trace[1274611882] 'agreement among raft nodes before linearized reading' (duration: 155.630901ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.864159Z","caller":"traceutil/trace.go:171","msg":"trace[1166476185] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:30; }","duration":"159.231639ms","start":"2026-05-07T09:12:33.704875Z","end":"2026-05-07T09:12:33.864106Z","steps":["trace[1166476185] 'agreement among raft nodes before linearized reading' (duration: 158.907296ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.865549Z","caller":"traceutil/trace.go:171","msg":"trace[920767648] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"103.65448ms","start":"2026-05-07T09:12:33.761872Z","end":"2026-05-07T09:12:33.865526Z","steps":["trace[920767648] 'process raft request' (duration: 103.62431ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.865695Z","caller":"traceutil/trace.go:171","msg":"trace[1018483402] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"104.154964ms","start":"2026-05-07T09:12:33.761524Z","end":"2026-05-07T09:12:33.865679Z","steps":["trace[1018483402] 'process raft request' (duration: 103.905293ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.865764Z","caller":"traceutil/trace.go:171","msg":"trace[1169726786] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"104.129914ms","start":"2026-05-07T09:12:33.761597Z","end":"2026-05-07T09:12:33.865727Z","steps":["trace[1169726786] 'process raft request' (duration: 103.867792ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:33.865854Z","caller":"traceutil/trace.go:171","msg":"trace[1729855551] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"104.620548ms","start":"2026-05-07T09:12:33.761225Z","end":"2026-05-07T09:12:33.865846Z","steps":["trace[1729855551] 'process raft request' (duration: 104.112104ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:34.755553Z","caller":"traceutil/trace.go:171","msg":"trace[152459971] transaction","detail":"{read_only:false; response_revision:82; number_of_response:1; }","duration":"111.303002ms","start":"2026-05-07T09:12:34.644231Z","end":"2026-05-07T09:12:34.755534Z","steps":["trace[152459971] 'process raft request' (duration: 93.166556ms)","trace[152459971] 'compare' (duration: 18.056765ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T09:12:34.988103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.972247ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-07T09:12:34.988197Z","caller":"traceutil/trace.go:171","msg":"trace[1653925965] linearizableReadLoop","detail":"{readStateIndex:90; appliedIndex:89; }","duration":"110.549177ms","start":"2026-05-07T09:12:34.87763Z","end":"2026-05-07T09:12:34.988179Z","steps":["trace[1653925965] 'read index received' (duration: 57.01µs)","trace[1653925965] 'applied index is now lower than readState.Index' (duration: 110.490697ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T09:12:34.988221Z","caller":"traceutil/trace.go:171","msg":"trace[1605148165] transaction","detail":"{read_only:false; response_revision:86; number_of_response:1; }","duration":"159.09584ms","start":"2026-05-07T09:12:34.829091Z","end":"2026-05-07T09:12:34.988187Z","steps":["trace[1605148165] 'process raft request' (duration: 38.287536ms)","trace[1605148165] 'compare' (duration: 119.845626ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T09:12:34.988437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.795518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-07T09:12:34.988509Z","caller":"traceutil/trace.go:171","msg":"trace[2085643571] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:86; }","duration":"110.91398ms","start":"2026-05-07T09:12:34.877581Z","end":"2026-05-07T09:12:34.988495Z","steps":["trace[2085643571] 'agreement among raft nodes before linearized reading' (duration: 110.678328ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:12:34.988562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.568987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-07T09:12:34.988798Z","caller":"traceutil/trace.go:171","msg":"trace[669349147] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:86; }","duration":"110.88175ms","start":"2026-05-07T09:12:34.877867Z","end":"2026-05-07T09:12:34.988749Z","steps":["trace[669349147] 'agreement among raft nodes before linearized reading' (duration: 110.446557ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:35.332974Z","caller":"traceutil/trace.go:171","msg":"trace[1377581026] transaction","detail":"{read_only:false; response_revision:102; number_of_response:1; }","duration":"121.789825ms","start":"2026-05-07T09:12:35.211141Z","end":"2026-05-07T09:12:35.332931Z","steps":["trace[1377581026] 'process raft request' (duration: 37.262287ms)","trace[1377581026] 'compare' (duration: 84.288366ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T09:12:35.44582Z","caller":"traceutil/trace.go:171","msg":"trace[846086542] transaction","detail":"{read_only:false; response_revision:103; number_of_response:1; }","duration":"106.829323ms","start":"2026-05-07T09:12:35.33896Z","end":"2026-05-07T09:12:35.445789Z","steps":["trace[846086542] 'process raft request' (duration: 105.863516ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:35.614058Z","caller":"traceutil/trace.go:171","msg":"trace[306541596] transaction","detail":"{read_only:false; response_revision:107; number_of_response:1; }","duration":"111.64428ms","start":"2026-05-07T09:12:35.50238Z","end":"2026-05-07T09:12:35.614025Z","steps":["trace[306541596] 'process raft request' (duration: 47.02361ms)","trace[306541596] 'compare' (duration: 64.229207ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T09:12:36.909777Z","caller":"traceutil/trace.go:171","msg":"trace[628287920] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"168.252853ms","start":"2026-05-07T09:12:36.741496Z","end":"2026-05-07T09:12:36.909749Z","steps":["trace[628287920] 'process raft request' (duration: 104.541392ms)","trace[628287920] 'compare' (duration: 63.58742ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T09:12:39.23727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.242194ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T09:12:39.237458Z","caller":"traceutil/trace.go:171","msg":"trace[763661794] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"123.89924ms","start":"2026-05-07T09:12:39.113541Z","end":"2026-05-07T09:12:39.23744Z","steps":["trace[763661794] 'process raft request' (duration: 123.838189ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:39.237533Z","caller":"traceutil/trace.go:171","msg":"trace[667270213] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"169.120418ms","start":"2026-05-07T09:12:39.068386Z","end":"2026-05-07T09:12:39.237507Z","steps":["trace[667270213] 'process raft request' (duration: 19.408751ms)","trace[667270213] 'compare' (duration: 149.104463ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T09:12:39.237527Z","caller":"traceutil/trace.go:171","msg":"trace[1003777278] linearizableReadLoop","detail":"{readStateIndex:281; appliedIndex:280; }","duration":"162.857162ms","start":"2026-05-07T09:12:39.074621Z","end":"2026-05-07T09:12:39.237478Z","steps":["trace[1003777278] 'read index received' (duration: 13.072735ms)","trace[1003777278] 'applied index is now lower than readState.Index' (duration: 149.779527ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T09:12:39.237687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.052214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-07T09:12:39.237729Z","caller":"traceutil/trace.go:171","msg":"trace[1511673249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:272; }","duration":"163.110585ms","start":"2026-05-07T09:12:39.074607Z","end":"2026-05-07T09:12:39.237718Z","steps":["trace[1511673249] 'agreement among raft nodes before linearized reading' (duration: 162.976024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:12:39.469973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.861011ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-07T09:12:39.470073Z","caller":"traceutil/trace.go:171","msg":"trace[1457408587] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"207.265544ms","start":"2026-05-07T09:12:39.26279Z","end":"2026-05-07T09:12:39.470056Z","steps":["trace[1457408587] 'process raft request' (duration: 91.254342ms)","trace[1457408587] 'compare' (duration: 115.71031ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T09:12:40.932877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.514364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-07T09:12:40.932962Z","caller":"traceutil/trace.go:171","msg":"trace[589725834] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:291; }","duration":"119.640314ms","start":"2026-05-07T09:12:40.8133Z","end":"2026-05-07T09:12:40.932941Z","steps":["trace[589725834] 'range keys from in-memory index tree' (duration: 119.431692ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:41.79937Z","caller":"traceutil/trace.go:171","msg":"trace[619580946] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"135.044031ms","start":"2026-05-07T09:12:41.664289Z","end":"2026-05-07T09:12:41.799333Z","steps":["trace[619580946] 'process raft request' (duration: 134.851649ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:12:42.273957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.415718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-05-07T09:12:42.274041Z","caller":"traceutil/trace.go:171","msg":"trace[650539744] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:304; }","duration":"110.53779ms","start":"2026-05-07T09:12:42.163484Z","end":"2026-05-07T09:12:42.274022Z","steps":["trace[650539744] 'range keys from in-memory index tree' (duration: 110.328658ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:12:42.673752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.159874ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-07T09:12:42.673866Z","caller":"traceutil/trace.go:171","msg":"trace[1346714756] linearizableReadLoop","detail":"{readStateIndex:324; appliedIndex:322; }","duration":"310.835701ms","start":"2026-05-07T09:12:42.363018Z","end":"2026-05-07T09:12:42.673854Z","steps":["trace[1346714756] 'read index received' (duration: 20.447626ms)","trace[1346714756] 'applied index is now lower than readState.Index' (duration: 290.387125ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T09:12:42.674005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.976702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-05-07T09:12:42.674049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.697788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-05-07T09:12:42.67407Z","caller":"traceutil/trace.go:171","msg":"trace[1498852981] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:311; }","duration":"160.736689ms","start":"2026-05-07T09:12:42.513326Z","end":"2026-05-07T09:12:42.674063Z","steps":["trace[1498852981] 'agreement among raft nodes before linearized reading' (duration: 160.705618ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:42.674069Z","caller":"traceutil/trace.go:171","msg":"trace[1348360693] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:311; }","duration":"311.067712ms","start":"2026-05-07T09:12:42.362984Z","end":"2026-05-07T09:12:42.674052Z","steps":["trace[1348360693] 'agreement among raft nodes before linearized reading' (duration: 310.943662ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:12:42.674105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:12:42.362976Z","time spent":"311.120333ms","remote":"127.0.0.1:36688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"warn","ts":"2026-05-07T09:12:42.674193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.967475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-05-07T09:12:42.674211Z","caller":"traceutil/trace.go:171","msg":"trace[284226633] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:311; }","duration":"110.006266ms","start":"2026-05-07T09:12:42.5642Z","end":"2026-05-07T09:12:42.674207Z","steps":["trace[284226633] 'agreement among raft nodes before linearized reading' (duration: 109.976155ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:12:42.674287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.907289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-07T09:12:42.674321Z","caller":"traceutil/trace.go:171","msg":"trace[2117897712] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:311; }","duration":"111.950949ms","start":"2026-05-07T09:12:42.562366Z","end":"2026-05-07T09:12:42.674317Z","steps":["trace[2117897712] 'agreement among raft nodes before linearized reading' (duration: 111.907119ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:42.674326Z","caller":"traceutil/trace.go:171","msg":"trace[1484331038] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"311.789027ms","start":"2026-05-07T09:12:42.362528Z","end":"2026-05-07T09:12:42.674317Z","steps":["trace[1484331038] 'process raft request' (duration: 311.295944ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:12:42.674294Z","caller":"traceutil/trace.go:171","msg":"trace[1449389697] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"311.788818ms","start":"2026-05-07T09:12:42.362491Z","end":"2026-05-07T09:12:42.674279Z","steps":["trace[1449389697] 'process raft request' (duration: 21.01172ms)","trace[1449389697] 'compare' (duration: 289.914992ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T09:12:42.674354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.515704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T09:12:42.674429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:12:42.362468Z","time spent":"311.940639ms","remote":"127.0.0.1:36846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2264,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T09:12:42.674452Z","caller":"traceutil/trace.go:171","msg":"trace[637738811] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:311; }","duration":"189.627845ms","start":"2026-05-07T09:12:42.484791Z","end":"2026-05-07T09:12:42.674419Z","steps":["trace[637738811] 'agreement among raft nodes before linearized reading' (duration: 189.497344ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:12:42.67401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.500581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-07T09:12:42.674708Z","caller":"traceutil/trace.go:171","msg":"trace[616904685] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:311; }","duration":"261.251837ms","start":"2026-05-07T09:12:42.413448Z","end":"2026-05-07T09:12:42.6747Z","steps":["trace[616904685] 'agreement among raft nodes before linearized reading' (duration: 260.541642ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:12:42.674385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:12:42.362496Z","time spent":"311.854619ms","remote":"127.0.0.1:36846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T09:12:42.674625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.509023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-05-07T09:12:42.674785Z","caller":"traceutil/trace.go:171","msg":"trace[371391255] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:311; }","duration":"207.669634ms","start":"2026-05-07T09:12:42.467111Z","end":"2026-05-07T09:12:42.674781Z","steps":["trace[371391255] 'agreement among raft nodes before linearized reading' (duration: 207.495162ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:12:58.410716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.797386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:476"} {"level":"info","ts":"2026-05-07T09:12:58.410807Z","caller":"traceutil/trace.go:171","msg":"trace[371154765] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:426; }","duration":"150.922151ms","start":"2026-05-07T09:12:58.259866Z","end":"2026-05-07T09:12:58.410788Z","steps":["trace[371154765] 'range keys from in-memory index tree' (duration: 150.619857ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:13:01.789616Z","caller":"traceutil/trace.go:171","msg":"trace[225411458] linearizableReadLoop","detail":"{readStateIndex:450; appliedIndex:449; }","duration":"307.007757ms","start":"2026-05-07T09:13:01.48258Z","end":"2026-05-07T09:13:01.789587Z","steps":["trace[225411458] 'read index received' (duration: 306.84497ms)","trace[225411458] 'applied index is now lower than readState.Index' (duration: 161.487µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T09:13:01.789738Z","caller":"traceutil/trace.go:171","msg":"trace[1036082579] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"315.58955ms","start":"2026-05-07T09:13:01.474137Z","end":"2026-05-07T09:13:01.789727Z","steps":["trace[1036082579] 'process raft request' (duration: 315.278216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:01.789861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:01.474113Z","time spent":"315.648532ms","remote":"127.0.0.1:36764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T09:13:01.789921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.322651ms","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-05-07T09:13:01.789989Z","caller":"traceutil/trace.go:171","msg":"trace[53141084] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:433; }","duration":"307.438176ms","start":"2026-05-07T09:13:01.482533Z","end":"2026-05-07T09:13:01.789971Z","steps":["trace[53141084] 'agreement among raft nodes before linearized reading' (duration: 307.334902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:01.790018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:01.482513Z","time spent":"307.500379ms","remote":"127.0.0.1:36764","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-05-07T09:13:01.803972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.196379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T09:13:01.804061Z","caller":"traceutil/trace.go:171","msg":"trace[565578932] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:433; }","duration":"296.331004ms","start":"2026-05-07T09:13:01.50771Z","end":"2026-05-07T09:13:01.804041Z","steps":["trace[565578932] 'agreement among raft nodes before linearized reading' (duration: 296.201198ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:13:04.412281Z","caller":"traceutil/trace.go:171","msg":"trace[156630009] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"481.128555ms","start":"2026-05-07T09:13:03.931101Z","end":"2026-05-07T09:13:04.412229Z","steps":["trace[156630009] 'process raft request' (duration: 478.557387ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:04.412513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:03.930757Z","time spent":"481.647218ms","remote":"127.0.0.1:36510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T09:13:04.418859Z","caller":"traceutil/trace.go:171","msg":"trace[700708352] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:541; }","duration":"457.216399ms","start":"2026-05-07T09:13:03.961601Z","end":"2026-05-07T09:13:04.418817Z","steps":["trace[700708352] 'read index received' (duration: 447.962581ms)","trace[700708352] 'applied index is now lower than readState.Index' (duration: 9.252938ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T09:13:04.418964Z","caller":"traceutil/trace.go:171","msg":"trace[1168823025] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"478.601985ms","start":"2026-05-07T09:13:03.940353Z","end":"2026-05-07T09:13:04.418955Z","steps":["trace[1168823025] 'process raft request' (duration: 478.23578ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:04.419196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.930373ms","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-05-07T09:13:04.419235Z","caller":"traceutil/trace.go:171","msg":"trace[1976775828] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:523; }","duration":"446.986655ms","start":"2026-05-07T09:13:03.972239Z","end":"2026-05-07T09:13:04.419225Z","steps":["trace[1976775828] 'agreement among raft nodes before linearized reading' (duration: 446.827759ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:04.419258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:03.972233Z","time spent":"447.020307ms","remote":"127.0.0.1:36764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-07T09:13:04.419398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.777473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:150495"} {"level":"info","ts":"2026-05-07T09:13:04.419463Z","caller":"traceutil/trace.go:171","msg":"trace[886575859] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:523; }","duration":"457.873057ms","start":"2026-05-07T09:13:03.961573Z","end":"2026-05-07T09:13:04.419446Z","steps":["trace[886575859] 'agreement among raft nodes before linearized reading' (duration: 457.593125ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:04.419506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:03.961559Z","time spent":"457.937159ms","remote":"127.0.0.1:36510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":1,"response size":150518,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-05-07T09:13:04.419718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:03.940312Z","time spent":"478.676308ms","remote":"127.0.0.1:36510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T09:13:10.698916Z","caller":"traceutil/trace.go:171","msg":"trace[1318194841] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"235.458862ms","start":"2026-05-07T09:13:10.463435Z","end":"2026-05-07T09:13:10.698893Z","steps":["trace[1318194841] 'read index received' (duration: 234.431092ms)","trace[1318194841] 'applied index is now lower than readState.Index' (duration: 1.02661ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T09:13:10.699063Z","caller":"traceutil/trace.go:171","msg":"trace[939057391] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"365.056798ms","start":"2026-05-07T09:13:10.333973Z","end":"2026-05-07T09:13:10.699029Z","steps":["trace[939057391] 'process raft request' (duration: 364.249836ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:10.699355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.90862ms","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-05-07T09:13:10.699719Z","caller":"traceutil/trace.go:171","msg":"trace[407270409] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:582; }","duration":"236.319396ms","start":"2026-05-07T09:13:10.46336Z","end":"2026-05-07T09:13:10.699679Z","steps":["trace[407270409] 'agreement among raft nodes before linearized reading' (duration: 235.748624ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:10.699722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:10.333948Z","time spent":"365.599178ms","remote":"127.0.0.1:36562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T09:13:10.700178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.609615ms","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-05-07T09:13:10.700258Z","caller":"traceutil/trace.go:171","msg":"trace[611661813] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:582; }","duration":"228.730149ms","start":"2026-05-07T09:13:10.471508Z","end":"2026-05-07T09:13:10.700238Z","steps":["trace[611661813] 'agreement among raft nodes before linearized reading' (duration: 228.570173ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:10.700333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.029913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T09:13:10.7004Z","caller":"traceutil/trace.go:171","msg":"trace[451686461] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"194.162259ms","start":"2026-05-07T09:13:10.506219Z","end":"2026-05-07T09:13:10.700381Z","steps":["trace[451686461] 'agreement among raft nodes before linearized reading' (duration: 194.045754ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:11.237186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.622068ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-07T09:13:11.237288Z","caller":"traceutil/trace.go:171","msg":"trace[884068457] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"265.674128ms","start":"2026-05-07T09:13:10.971597Z","end":"2026-05-07T09:13:11.237272Z","steps":["trace[884068457] 'read index received' (duration: 157.906804ms)","trace[884068457] 'applied index is now lower than readState.Index' (duration: 107.766194ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T09:13:11.237315Z","caller":"traceutil/trace.go:171","msg":"trace[1026395347] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"468.888571ms","start":"2026-05-07T09:13:10.768395Z","end":"2026-05-07T09:13:11.237284Z","steps":["trace[1026395347] 'process raft request' (duration: 361.106136ms)","trace[1026395347] 'compare' (duration: 107.473313ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T09:13:11.237443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:10.768372Z","time spent":"469.011666ms","remote":"127.0.0.1:36730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-07T09:13:11.237615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.005802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dj4hj\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-07T09:13:11.23765Z","caller":"traceutil/trace.go:171","msg":"trace[1404582218] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dj4hj; range_end:; response_count:1; response_revision:585; }","duration":"266.075754ms","start":"2026-05-07T09:13:10.971565Z","end":"2026-05-07T09:13:11.23764Z","steps":["trace[1404582218] 'agreement among raft nodes before linearized reading' (duration: 265.752432ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:11.941464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.979459ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-07T09:13:11.941573Z","caller":"traceutil/trace.go:171","msg":"trace[329591658] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"690.115684ms","start":"2026-05-07T09:13:11.251437Z","end":"2026-05-07T09:13:11.941552Z","steps":["trace[329591658] 'process raft request' (duration: 520.976159ms)","trace[329591658] 'compare' (duration: 168.843174ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T09:13:11.941632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:11.251421Z","time spent":"690.186708ms","remote":"127.0.0.1:36670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T09:13:12.460896Z","caller":"traceutil/trace.go:171","msg":"trace[1916830788] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:606; }","duration":"953.21056ms","start":"2026-05-07T09:13:11.507666Z","end":"2026-05-07T09:13:12.460877Z","steps":["trace[1916830788] 'read index received' (duration: 264.841803ms)","trace[1916830788] 'applied index is now lower than readState.Index' (duration: 688.368047ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T09:13:12.460974Z","caller":"traceutil/trace.go:171","msg":"trace[507359022] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"1.208721363s","start":"2026-05-07T09:13:11.252235Z","end":"2026-05-07T09:13:12.460957Z","steps":["trace[507359022] 'process raft request' (duration: 1.208221533s)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:12.461047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"953.373747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T09:13:12.461081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:11.252219Z","time spent":"1.208799596s","remote":"127.0.0.1:36670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-07T09:13:12.461088Z","caller":"traceutil/trace.go:171","msg":"trace[1229520110] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"953.4528ms","start":"2026-05-07T09:13:11.507612Z","end":"2026-05-07T09:13:12.461065Z","steps":["trace[1229520110] 'agreement among raft nodes before linearized reading' (duration: 953.391177ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:12.461114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:11.507593Z","time spent":"953.514452ms","remote":"127.0.0.1:36456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-07T09:13:12.479418Z","caller":"traceutil/trace.go:171","msg":"trace[274341802] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"533.415953ms","start":"2026-05-07T09:13:11.945944Z","end":"2026-05-07T09:13:12.47936Z","steps":["trace[274341802] 'process raft request' (duration: 533.117361ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:13:12.479451Z","caller":"traceutil/trace.go:171","msg":"trace[627466361] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"532.951205ms","start":"2026-05-07T09:13:11.946463Z","end":"2026-05-07T09:13:12.479414Z","steps":["trace[627466361] 'process raft request' (duration: 532.721446ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:12.479614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:11.946448Z","time spent":"533.07796ms","remote":"127.0.0.1:36538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-07T09:13:12.479627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:11.945925Z","time spent":"533.59549ms","remote":"127.0.0.1:36538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-07T09:13:12.479688Z","caller":"traceutil/trace.go:171","msg":"trace[1408827120] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"532.900382ms","start":"2026-05-07T09:13:11.946708Z","end":"2026-05-07T09:13:12.479608Z","steps":["trace[1408827120] 'process raft request' (duration: 532.521438ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:12.479882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:11.946698Z","time spent":"533.09839ms","remote":"127.0.0.1:36730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T09:13:12.479925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.059058ms","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-05-07T09:13:12.47997Z","caller":"traceutil/trace.go:171","msg":"trace[332728556] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:591; }","duration":"577.150452ms","start":"2026-05-07T09:13:11.902808Z","end":"2026-05-07T09:13:12.479958Z","steps":["trace[332728556] 'agreement among raft nodes before linearized reading' (duration: 576.959405ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:12.480033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:11.902777Z","time spent":"577.248616ms","remote":"127.0.0.1:36764","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-05-07T09:13:12.480103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.425353ms","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-05-07T09:13:12.480144Z","caller":"traceutil/trace.go:171","msg":"trace[1309653699] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"532.039629ms","start":"2026-05-07T09:13:11.948084Z","end":"2026-05-07T09:13:12.480123Z","steps":["trace[1309653699] 'process raft request' (duration: 531.29617ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:13:12.480202Z","caller":"traceutil/trace.go:171","msg":"trace[134539576] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:591; }","duration":"577.61535ms","start":"2026-05-07T09:13:11.902565Z","end":"2026-05-07T09:13:12.480181Z","steps":["trace[134539576] 'agreement among raft nodes before linearized reading' (duration: 577.3619ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:12.480266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:11.902532Z","time spent":"577.711353ms","remote":"127.0.0.1:36764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-07T09:13:12.480283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:11.948074Z","time spent":"532.124422ms","remote":"127.0.0.1:36670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T09:13:12.480513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.615123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T09:13:12.480551Z","caller":"traceutil/trace.go:171","msg":"trace[691457406] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:591; }","duration":"145.674885ms","start":"2026-05-07T09:13:12.334866Z","end":"2026-05-07T09:13:12.480541Z","steps":["trace[691457406] 'agreement among raft nodes before linearized reading' (duration: 145.611892ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:12.480614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.80223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T09:13:12.480644Z","caller":"traceutil/trace.go:171","msg":"trace[23359841] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:591; }","duration":"145.918304ms","start":"2026-05-07T09:13:12.334718Z","end":"2026-05-07T09:13:12.480636Z","steps":["trace[23359841] 'agreement among raft nodes before linearized reading' (duration: 145.437506ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:13:14.342521Z","caller":"traceutil/trace.go:171","msg":"trace[1166670737] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"180.4673ms","start":"2026-05-07T09:13:14.162018Z","end":"2026-05-07T09:13:14.342486Z","steps":["trace[1166670737] 'process raft request' (duration: 180.348965ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:13:32.845237Z","caller":"traceutil/trace.go:171","msg":"trace[1086270618] linearizableReadLoop","detail":"{readStateIndex:778; appliedIndex:777; }","duration":"216.037905ms","start":"2026-05-07T09:13:32.629175Z","end":"2026-05-07T09:13:32.845213Z","steps":["trace[1086270618] 'read index received' (duration: 215.706335ms)","trace[1086270618] 'applied index is now lower than readState.Index' (duration: 330.57µs)"],"step_count":2} {"level":"info","ts":"2026-05-07T09:13:32.845435Z","caller":"traceutil/trace.go:171","msg":"trace[843592814] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"241.644823ms","start":"2026-05-07T09:13:32.60375Z","end":"2026-05-07T09:13:32.845395Z","steps":["trace[843592814] 'process raft request' (duration: 241.2373ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:32.845505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.307163ms","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-05-07T09:13:32.845674Z","caller":"traceutil/trace.go:171","msg":"trace[968214831] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:751; }","duration":"216.50446ms","start":"2026-05-07T09:13:32.62915Z","end":"2026-05-07T09:13:32.845654Z","steps":["trace[968214831] 'agreement among raft nodes before linearized reading' (duration: 216.224821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:35.591159Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393189869051759,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-07T09:13:35.84736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"988.793512ms","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-05-07T09:13:35.847454Z","caller":"traceutil/trace.go:171","msg":"trace[715001147] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:763; }","duration":"988.966127ms","start":"2026-05-07T09:13:34.858464Z","end":"2026-05-07T09:13:35.84743Z","steps":["trace[715001147] 'range keys from in-memory index tree' (duration: 988.591656ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:35.847456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.336291ms","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-05-07T09:13:35.8475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.849447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-05-07T09:13:35.847511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:34.858443Z","time spent":"989.05426ms","remote":"127.0.0.1:36764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-07T09:13:35.84753Z","caller":"traceutil/trace.go:171","msg":"trace[1838568605] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:763; }","duration":"864.437084ms","start":"2026-05-07T09:13:34.983071Z","end":"2026-05-07T09:13:35.847509Z","steps":["trace[1838568605] 'range keys from in-memory index tree' (duration: 864.210047ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:35.847559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:34.983058Z","time spent":"864.495616ms","remote":"127.0.0.1:36764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-07T09:13:35.847562Z","caller":"traceutil/trace.go:171","msg":"trace[1058057931] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:763; }","duration":"864.937969ms","start":"2026-05-07T09:13:34.982604Z","end":"2026-05-07T09:13:35.847542Z","steps":["trace[1058057931] 'range keys from in-memory index tree' (duration: 864.685442ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:35.847597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:34.982583Z","time spent":"865.005342ms","remote":"127.0.0.1:36764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-07T09:13:35.847597Z","caller":"traceutil/trace.go:171","msg":"trace[2074157074] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"791.059108ms","start":"2026-05-07T09:13:35.056519Z","end":"2026-05-07T09:13:35.847578Z","steps":["trace[2074157074] 'process raft request' (duration: 789.76467ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:13:35.84758Z","caller":"traceutil/trace.go:171","msg":"trace[676612728] linearizableReadLoop","detail":"{readStateIndex:791; appliedIndex:790; }","duration":"757.158547ms","start":"2026-05-07T09:13:35.090384Z","end":"2026-05-07T09:13:35.847543Z","steps":["trace[676612728] 'read index received' (duration: 755.856539ms)","trace[676612728] 'applied index is now lower than readState.Index' (duration: 1.299158ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T09:13:35.847707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:35.0565Z","time spent":"791.141461ms","remote":"127.0.0.1:36764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-07T09:13:35.847767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.227489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-07T09:13:35.847777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.380574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-g69fn\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-05-07T09:13:35.847805Z","caller":"traceutil/trace.go:171","msg":"trace[1400568231] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:764; }","duration":"340.313772ms","start":"2026-05-07T09:13:35.507479Z","end":"2026-05-07T09:13:35.847793Z","steps":["trace[1400568231] 'agreement among raft nodes before linearized reading' (duration: 340.219129ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:13:35.847829Z","caller":"traceutil/trace.go:171","msg":"trace[189036100] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-g69fn; range_end:; response_count:1; response_revision:764; }","duration":"757.460006ms","start":"2026-05-07T09:13:35.090353Z","end":"2026-05-07T09:13:35.847813Z","steps":["trace[189036100] 'agreement among raft nodes before linearized reading' (duration: 757.309522ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:35.847841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:35.507458Z","time spent":"340.374794ms","remote":"127.0.0.1:36456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-07T09:13:35.847864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:35.090341Z","time spent":"757.514168ms","remote":"127.0.0.1:36670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-g69fn\" "} {"level":"warn","ts":"2026-05-07T09:13:35.848193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"998.505194ms","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-05-07T09:13:35.848239Z","caller":"traceutil/trace.go:171","msg":"trace[1501697521] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:763; }","duration":"998.584077ms","start":"2026-05-07T09:13:34.849639Z","end":"2026-05-07T09:13:35.848223Z","steps":["trace[1501697521] 'range keys from in-memory index tree' (duration: 997.415682ms)"],"step_count":1} {"level":"warn","ts":"2026-05-07T09:13:35.848272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T09:13:34.849623Z","time spent":"998.642008ms","remote":"127.0.0.1:36764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-07T09:13:46.223509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.430608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-07T09:13:46.223634Z","caller":"traceutil/trace.go:171","msg":"trace[1348474219] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:889; }","duration":"175.584172ms","start":"2026-05-07T09:13:46.047979Z","end":"2026-05-07T09:13:46.223563Z","steps":["trace[1348474219] 'range keys from in-memory index tree' (duration: 175.293975ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:13:46.223706Z","caller":"traceutil/trace.go:171","msg":"trace[1309641404] linearizableReadLoop","detail":"{readStateIndex:920; appliedIndex:919; }","duration":"105.583877ms","start":"2026-05-07T09:13:46.118101Z","end":"2026-05-07T09:13:46.223684Z","steps":["trace[1309641404] 'read index received' (duration: 47.378719ms)","trace[1309641404] 'applied index is now lower than readState.Index' (duration: 58.203858ms)"],"step_count":2} {"level":"warn","ts":"2026-05-07T09:13:46.223846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.743241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-07T09:13:46.223894Z","caller":"traceutil/trace.go:171","msg":"trace[2102074726] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:0; response_revision:890; }","duration":"105.831015ms","start":"2026-05-07T09:13:46.118048Z","end":"2026-05-07T09:13:46.223879Z","steps":["trace[2102074726] 'agreement among raft nodes before linearized reading' (duration: 105.715141ms)"],"step_count":1} {"level":"info","ts":"2026-05-07T09:13:46.224033Z","caller":"traceutil/trace.go:171","msg":"trace[484159695] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"112.366179ms","start":"2026-05-07T09:13:46.111612Z","end":"2026-05-07T09:13:46.223978Z","steps":["trace[484159695] 'process raft request' (duration: 53.872203ms)","trace[484159695] 'compare' (duration: 58.051624ms)"],"step_count":2} {"level":"info","ts":"2026-05-07T09:15:26.748725Z","caller":"traceutil/trace.go:171","msg":"trace[1194450196] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"144.381261ms","start":"2026-05-07T09:15:26.604307Z","end":"2026-05-07T09:15:26.748688Z","steps":["trace[1194450196] 'process raft request' (duration: 144.203228ms)"],"step_count":1}