{"level":"warn","ts":"2026-04-21T19:12:33.971394Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-21T19:12:33.971512Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.116:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.116:2380","--initial-cluster=instance=https://199.204.45.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.116:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-21T19:12:33.971621Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-21T19:12:33.971636Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-04-21T19:12:33.971662Z","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-04-21T19:12:33.972669Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"]} {"level":"info","ts":"2026-04-21T19:12:33.972783Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.116:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-21T19:12:33.977663Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.568666ms"} {"level":"info","ts":"2026-04-21T19:12:33.992948Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5caa70ef1dd6dc04","cluster-id":"45afccab143d2c82"} {"level":"info","ts":"2026-04-21T19:12:33.993053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=()"} {"level":"info","ts":"2026-04-21T19:12:33.993082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 0"} {"level":"info","ts":"2026-04-21T19:12:33.993096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5caa70ef1dd6dc04 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-21T19:12:33.993112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 1"} {"level":"info","ts":"2026-04-21T19:12:33.993201Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"warn","ts":"2026-04-21T19:12:34.0168Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-21T19:12:34.020978Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-21T19:12:34.025871Z","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-04-21T19:12:34.028235Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5caa70ef1dd6dc04","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-21T19:12:34.028514Z","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-04-21T19:12:34.028597Z","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-04-21T19:12:34.028609Z","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-04-21T19:12:34.02874Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5caa70ef1dd6dc04","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-21T19:12:34.036464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"info","ts":"2026-04-21T19:12:34.037587Z","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-04-21T19:12:34.037688Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-04-21T19:12:34.037721Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-04-21T19:12:34.037856Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5caa70ef1dd6dc04","initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-21T19:12:34.037901Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-21T19:12:34.040357Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","added-peer-id":"5caa70ef1dd6dc04","added-peer-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-04-21T19:12:34.695335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 is starting a new election at term 1"} {"level":"info","ts":"2026-04-21T19:12:34.695422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-21T19:12:34.6955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgPreVoteResp from 5caa70ef1dd6dc04 at term 1"} {"level":"info","ts":"2026-04-21T19:12:34.695529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became candidate at term 2"} {"level":"info","ts":"2026-04-21T19:12:34.695546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgVoteResp from 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-04-21T19:12:34.695571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became leader at term 2"} {"level":"info","ts":"2026-04-21T19:12:34.695592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5caa70ef1dd6dc04 elected leader 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-04-21T19:12:34.696925Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5caa70ef1dd6dc04","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.116:2379]}","request-path":"/0/members/5caa70ef1dd6dc04/attributes","cluster-id":"45afccab143d2c82","publish-timeout":"7s"} {"level":"info","ts":"2026-04-21T19:12:34.696941Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T19:12:34.697184Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T19:12:34.697255Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T19:12:34.697606Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-21T19:12:34.697747Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-21T19:12:34.698012Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T19:12:34.698156Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T19:12:34.698195Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T19:12:34.699708Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-21T19:12:34.701019Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.116:2379"} {"level":"info","ts":"2026-04-21T19:12:37.53669Z","caller":"traceutil/trace.go:171","msg":"trace[127044929] transaction","detail":"{read_only:false; response_revision:147; number_of_response:1; }","duration":"108.774106ms","start":"2026-04-21T19:12:37.427885Z","end":"2026-04-21T19:12:37.53666Z","steps":["trace[127044929] 'process raft request' (duration: 60.974917ms)","trace[127044929] 'compare' (duration: 47.618194ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:12:40.247604Z","caller":"traceutil/trace.go:171","msg":"trace[716828816] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"118.173757ms","start":"2026-04-21T19:12:40.129391Z","end":"2026-04-21T19:12:40.247565Z","steps":["trace[716828816] 'process raft request' (duration: 39.07417ms)","trace[716828816] 'compare' (duration: 78.918362ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:12:40.497157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.969816ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:12:40.497303Z","caller":"traceutil/trace.go:171","msg":"trace[431750134] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"190.190717ms","start":"2026-04-21T19:12:40.307089Z","end":"2026-04-21T19:12:40.49728Z","steps":["trace[431750134] 'process raft request' (duration: 51.46225ms)","trace[431750134] 'compare' (duration: 137.8076ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:12:40.497342Z","caller":"traceutil/trace.go:171","msg":"trace[251145366] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"165.628134ms","start":"2026-04-21T19:12:40.331701Z","end":"2026-04-21T19:12:40.497329Z","steps":["trace[251145366] 'process raft request' (duration: 165.572796ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:40.497383Z","caller":"traceutil/trace.go:171","msg":"trace[526929075] linearizableReadLoop","detail":"{readStateIndex:311; appliedIndex:310; }","duration":"170.066205ms","start":"2026-04-21T19:12:40.327301Z","end":"2026-04-21T19:12:40.497368Z","steps":["trace[526929075] 'read index received' (duration: 31.24924ms)","trace[526929075] 'applied index is now lower than readState.Index' (duration: 138.814765ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:12:40.497506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.183342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-04-21T19:12:40.497526Z","caller":"traceutil/trace.go:171","msg":"trace[368750959] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:302; }","duration":"170.251181ms","start":"2026-04-21T19:12:40.327268Z","end":"2026-04-21T19:12:40.497519Z","steps":["trace[368750959] 'agreement among raft nodes before linearized reading' (duration: 170.168863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:12:40.497558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.312679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:12:40.497607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.797563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"warn","ts":"2026-04-21T19:12:40.4976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.219612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"warn","ts":"2026-04-21T19:12:40.497627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.205202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3980"} {"level":"info","ts":"2026-04-21T19:12:40.497654Z","caller":"traceutil/trace.go:171","msg":"trace[1338355890] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:302; }","duration":"169.87986ms","start":"2026-04-21T19:12:40.327761Z","end":"2026-04-21T19:12:40.497641Z","steps":["trace[1338355890] 'agreement among raft nodes before linearized reading' (duration: 169.786983ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:40.497686Z","caller":"traceutil/trace.go:171","msg":"trace[165215851] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:302; }","duration":"170.278071ms","start":"2026-04-21T19:12:40.327388Z","end":"2026-04-21T19:12:40.497666Z","steps":["trace[165215851] 'agreement among raft nodes before linearized reading' (duration: 170.194273ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:40.497622Z","caller":"traceutil/trace.go:171","msg":"trace[1167278679] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:0; response_revision:302; }","duration":"168.400556ms","start":"2026-04-21T19:12:40.329204Z","end":"2026-04-21T19:12:40.497604Z","steps":["trace[1167278679] 'agreement among raft nodes before linearized reading' (duration: 168.300769ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:40.497691Z","caller":"traceutil/trace.go:171","msg":"trace[172617663] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:302; }","duration":"170.320509ms","start":"2026-04-21T19:12:40.327337Z","end":"2026-04-21T19:12:40.497658Z","steps":["trace[172617663] 'agreement among raft nodes before linearized reading' (duration: 170.171393ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:40.726686Z","caller":"traceutil/trace.go:171","msg":"trace[1710472240] linearizableReadLoop","detail":"{readStateIndex:321; appliedIndex:318; }","duration":"172.303241ms","start":"2026-04-21T19:12:40.554364Z","end":"2026-04-21T19:12:40.726668Z","steps":["trace[1710472240] 'read index received' (duration: 127.262106ms)","trace[1710472240] 'applied index is now lower than readState.Index' (duration: 45.039745ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:12:40.727612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.223049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-21T19:12:40.727706Z","caller":"traceutil/trace.go:171","msg":"trace[1571659772] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:311; }","duration":"173.336747ms","start":"2026-04-21T19:12:40.554335Z","end":"2026-04-21T19:12:40.727671Z","steps":["trace[1571659772] 'agreement among raft nodes before linearized reading' (duration: 172.415009ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:40.728104Z","caller":"traceutil/trace.go:171","msg":"trace[881736580] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"195.524868ms","start":"2026-04-21T19:12:40.532561Z","end":"2026-04-21T19:12:40.728085Z","steps":["trace[881736580] 'process raft request' (duration: 194.069313ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:40.728335Z","caller":"traceutil/trace.go:171","msg":"trace[1993038904] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"194.60706ms","start":"2026-04-21T19:12:40.532408Z","end":"2026-04-21T19:12:40.727015Z","steps":["trace[1993038904] 'process raft request' (duration: 194.156591ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:40.729559Z","caller":"traceutil/trace.go:171","msg":"trace[356058566] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"197.88033ms","start":"2026-04-21T19:12:40.531641Z","end":"2026-04-21T19:12:40.729522Z","steps":["trace[356058566] 'process raft request' (duration: 149.999704ms)","trace[356058566] 'compare' (duration: 44.759812ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:12:43.334554Z","caller":"traceutil/trace.go:171","msg":"trace[1645241560] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"124.379082ms","start":"2026-04-21T19:12:43.210145Z","end":"2026-04-21T19:12:43.334524Z","steps":["trace[1645241560] 'process raft request' (duration: 43.546285ms)","trace[1645241560] 'compare' (duration: 80.690561ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:12:43.516248Z","caller":"traceutil/trace.go:171","msg":"trace[1329521144] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"105.516213ms","start":"2026-04-21T19:12:43.410701Z","end":"2026-04-21T19:12:43.516217Z","steps":["trace[1329521144] 'process raft request' (duration: 38.333406ms)","trace[1329521144] 'compare' (duration: 66.987222ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:12:44.159994Z","caller":"traceutil/trace.go:171","msg":"trace[1097978249] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"137.736935ms","start":"2026-04-21T19:12:44.022221Z","end":"2026-04-21T19:12:44.159957Z","steps":["trace[1097978249] 'process raft request' (duration: 69.061627ms)","trace[1097978249] 'compare' (duration: 68.257338ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:12:44.160424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.04423ms","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-04-21T19:12:44.160533Z","caller":"traceutil/trace.go:171","msg":"trace[2117554268] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:352; }","duration":"100.184487ms","start":"2026-04-21T19:12:44.060328Z","end":"2026-04-21T19:12:44.160512Z","steps":["trace[2117554268] 'agreement among raft nodes before linearized reading' (duration: 100.006491ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:44.568594Z","caller":"traceutil/trace.go:171","msg":"trace[466996976] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"257.344164ms","start":"2026-04-21T19:12:44.311233Z","end":"2026-04-21T19:12:44.568577Z","steps":["trace[466996976] 'process raft request' (duration: 257.13371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:12:44.56876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.50988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-04-21T19:12:44.568842Z","caller":"traceutil/trace.go:171","msg":"trace[593524295] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:374; }","duration":"259.646027ms","start":"2026-04-21T19:12:44.30918Z","end":"2026-04-21T19:12:44.568826Z","steps":["trace[593524295] 'agreement among raft nodes before linearized reading' (duration: 259.5083ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:44.568906Z","caller":"traceutil/trace.go:171","msg":"trace[554481817] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"259.194258ms","start":"2026-04-21T19:12:44.309272Z","end":"2026-04-21T19:12:44.568467Z","steps":["trace[554481817] 'process raft request' (duration: 196.790943ms)","trace[554481817] 'compare' (duration: 62.121912ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:12:44.568495Z","caller":"traceutil/trace.go:171","msg":"trace[1030094631] linearizableReadLoop","detail":"{readStateIndex:387; appliedIndex:385; }","duration":"215.66931ms","start":"2026-04-21T19:12:44.352797Z","end":"2026-04-21T19:12:44.568466Z","steps":["trace[1030094631] 'read index received' (duration: 153.400251ms)","trace[1030094631] 'applied index is now lower than readState.Index' (duration: 62.267959ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:12:44.571274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.932929ms","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-04-21T19:12:44.571524Z","caller":"traceutil/trace.go:171","msg":"trace[1341229914] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:375; }","duration":"211.257291ms","start":"2026-04-21T19:12:44.360243Z","end":"2026-04-21T19:12:44.5715Z","steps":["trace[1341229914] 'agreement among raft nodes before linearized reading' (duration: 210.954019ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:44.571943Z","caller":"traceutil/trace.go:171","msg":"trace[1194792678] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"204.311795ms","start":"2026-04-21T19:12:44.367614Z","end":"2026-04-21T19:12:44.571925Z","steps":["trace[1194792678] 'process raft request' (duration: 203.472196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:12:44.571984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.763377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-21T19:12:44.57252Z","caller":"traceutil/trace.go:171","msg":"trace[1540781615] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:375; }","duration":"163.341702ms","start":"2026-04-21T19:12:44.409165Z","end":"2026-04-21T19:12:44.572507Z","steps":["trace[1540781615] 'agreement among raft nodes before linearized reading' (duration: 162.752197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:12:44.572052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.377877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-04-21T19:12:44.572772Z","caller":"traceutil/trace.go:171","msg":"trace[1998692750] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:375; }","duration":"153.127388ms","start":"2026-04-21T19:12:44.419626Z","end":"2026-04-21T19:12:44.572754Z","steps":["trace[1998692750] 'agreement among raft nodes before linearized reading' (duration: 152.389937ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:44.750933Z","caller":"traceutil/trace.go:171","msg":"trace[825404838] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"127.19078ms","start":"2026-04-21T19:12:44.62372Z","end":"2026-04-21T19:12:44.750911Z","steps":["trace[825404838] 'process raft request' (duration: 94.966448ms)","trace[825404838] 'compare' (duration: 32.126655ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:12:44.755906Z","caller":"traceutil/trace.go:171","msg":"trace[1789903921] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"129.14201ms","start":"2026-04-21T19:12:44.62675Z","end":"2026-04-21T19:12:44.755892Z","steps":["trace[1789903921] 'process raft request' (duration: 129.024623ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:44.756093Z","caller":"traceutil/trace.go:171","msg":"trace[1963470935] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"126.584306ms","start":"2026-04-21T19:12:44.629495Z","end":"2026-04-21T19:12:44.756079Z","steps":["trace[1963470935] 'process raft request' (duration: 126.322222ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:44.756082Z","caller":"traceutil/trace.go:171","msg":"trace[473091743] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"131.903211ms","start":"2026-04-21T19:12:44.624155Z","end":"2026-04-21T19:12:44.756059Z","steps":["trace[473091743] 'process raft request' (duration: 131.5514ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:44.936521Z","caller":"traceutil/trace.go:171","msg":"trace[253295433] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"108.687573ms","start":"2026-04-21T19:12:44.82781Z","end":"2026-04-21T19:12:44.936497Z","steps":["trace[253295433] 'process raft request' (duration: 101.755987ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:50.530472Z","caller":"traceutil/trace.go:171","msg":"trace[212133310] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"271.814679ms","start":"2026-04-21T19:12:50.258638Z","end":"2026-04-21T19:12:50.530453Z","steps":["trace[212133310] 'process raft request' (duration: 271.689342ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:50.621795Z","caller":"traceutil/trace.go:171","msg":"trace[6622819] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"356.880571ms","start":"2026-04-21T19:12:50.264895Z","end":"2026-04-21T19:12:50.621776Z","steps":["trace[6622819] 'process raft request' (duration: 356.703295ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:50.622015Z","caller":"traceutil/trace.go:171","msg":"trace[286242024] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"189.009459ms","start":"2026-04-21T19:12:50.432971Z","end":"2026-04-21T19:12:50.621981Z","steps":["trace[286242024] 'process raft request' (duration: 188.763426ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:12:50.622267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:12:50.264867Z","time spent":"356.996507ms","remote":"127.0.0.1:39608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4649,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:12:51.689273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.636475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:12:51.689353Z","caller":"traceutil/trace.go:171","msg":"trace[1969376957] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:421; }","duration":"104.766952ms","start":"2026-04-21T19:12:51.584567Z","end":"2026-04-21T19:12:51.689334Z","steps":["trace[1969376957] 'range keys from in-memory index tree' (duration: 104.569127ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:53.08311Z","caller":"traceutil/trace.go:171","msg":"trace[327419465] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"100.191486ms","start":"2026-04-21T19:12:52.982891Z","end":"2026-04-21T19:12:53.083082Z","steps":["trace[327419465] 'process raft request' (duration: 100.04522ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:53.387844Z","caller":"traceutil/trace.go:171","msg":"trace[58094095] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"123.149684ms","start":"2026-04-21T19:12:53.264674Z","end":"2026-04-21T19:12:53.387824Z","steps":["trace[58094095] 'process raft request' (duration: 41.062511ms)","trace[58094095] 'compare' (duration: 81.958216ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:12:53.392805Z","caller":"traceutil/trace.go:171","msg":"trace[85433840] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"127.319584ms","start":"2026-04-21T19:12:53.265464Z","end":"2026-04-21T19:12:53.392784Z","steps":["trace[85433840] 'process raft request' (duration: 127.190638ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:53.392971Z","caller":"traceutil/trace.go:171","msg":"trace[1744656994] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"127.931298ms","start":"2026-04-21T19:12:53.265019Z","end":"2026-04-21T19:12:53.39295Z","steps":["trace[1744656994] 'process raft request' (duration: 127.536908ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:53.393088Z","caller":"traceutil/trace.go:171","msg":"trace[1760504173] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"125.876932ms","start":"2026-04-21T19:12:53.267182Z","end":"2026-04-21T19:12:53.393059Z","steps":["trace[1760504173] 'process raft request' (duration: 125.519191ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:53.39322Z","caller":"traceutil/trace.go:171","msg":"trace[425252181] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"125.687176ms","start":"2026-04-21T19:12:53.267496Z","end":"2026-04-21T19:12:53.393183Z","steps":["trace[425252181] 'process raft request' (duration: 125.237399ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:53.393211Z","caller":"traceutil/trace.go:171","msg":"trace[47020823] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"125.465003ms","start":"2026-04-21T19:12:53.267667Z","end":"2026-04-21T19:12:53.393132Z","steps":["trace[47020823] 'process raft request' (duration: 125.086713ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:12:59.694031Z","caller":"traceutil/trace.go:171","msg":"trace[483436933] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"274.312619ms","start":"2026-04-21T19:12:59.41969Z","end":"2026-04-21T19:12:59.694002Z","steps":["trace[483436933] 'process raft request' (duration: 274.138604ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:13:06.516405Z","caller":"traceutil/trace.go:171","msg":"trace[1508528514] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"152.975235ms","start":"2026-04-21T19:13:06.363402Z","end":"2026-04-21T19:13:06.516377Z","steps":["trace[1508528514] 'process raft request' (duration: 152.779178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:06.920609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.479932ms","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-04-21T19:13:06.92074Z","caller":"traceutil/trace.go:171","msg":"trace[1931683788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:517; }","duration":"306.674448ms","start":"2026-04-21T19:13:06.614033Z","end":"2026-04-21T19:13:06.920708Z","steps":["trace[1931683788] 'range keys from in-memory index tree' (duration: 306.237802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:06.920795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:06.614007Z","time spent":"306.776597ms","remote":"127.0.0.1:39694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-21T19:13:07.411739Z","caller":"traceutil/trace.go:171","msg":"trace[994270204] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"385.836321ms","start":"2026-04-21T19:13:07.025869Z","end":"2026-04-21T19:13:07.411706Z","steps":["trace[994270204] 'process raft request' (duration: 299.602186ms)","trace[994270204] 'compare' (duration: 85.593393ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:13:07.41191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:07.025847Z","time spent":"385.973622ms","remote":"127.0.0.1:39694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:13:07.424186Z","caller":"traceutil/trace.go:171","msg":"trace[472808474] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"271.959183ms","start":"2026-04-21T19:13:07.152197Z","end":"2026-04-21T19:13:07.424156Z","steps":["trace[472808474] 'process raft request' (duration: 271.519067ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:13:07.424671Z","caller":"traceutil/trace.go:171","msg":"trace[2045190426] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"192.34527ms","start":"2026-04-21T19:13:07.23229Z","end":"2026-04-21T19:13:07.424635Z","steps":["trace[2045190426] 'process raft request' (duration: 192.287665ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:13:07.424852Z","caller":"traceutil/trace.go:171","msg":"trace[1407986209] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"258.729534ms","start":"2026-04-21T19:13:07.166097Z","end":"2026-04-21T19:13:07.424827Z","steps":["trace[1407986209] 'process raft request' (duration: 258.129636ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:13:07.424884Z","caller":"traceutil/trace.go:171","msg":"trace[1636600697] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"252.642677ms","start":"2026-04-21T19:13:07.172208Z","end":"2026-04-21T19:13:07.424851Z","steps":["trace[1636600697] 'process raft request' (duration: 252.156758ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:13:07.424953Z","caller":"traceutil/trace.go:171","msg":"trace[236428591] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"260.129106ms","start":"2026-04-21T19:13:07.16481Z","end":"2026-04-21T19:13:07.42494Z","steps":["trace[236428591] 'process raft request' (duration: 259.198632ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:13:07.424938Z","caller":"traceutil/trace.go:171","msg":"trace[1821731493] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"256.168289ms","start":"2026-04-21T19:13:07.168734Z","end":"2026-04-21T19:13:07.424902Z","steps":["trace[1821731493] 'process raft request' (duration: 255.539839ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:13:07.424997Z","caller":"traceutil/trace.go:171","msg":"trace[1204583910] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"260.091694ms","start":"2026-04-21T19:13:07.164878Z","end":"2026-04-21T19:13:07.424969Z","steps":["trace[1204583910] 'process raft request' (duration: 259.204813ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:13:07.424906Z","caller":"traceutil/trace.go:171","msg":"trace[1717064281] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"240.912358ms","start":"2026-04-21T19:13:07.183967Z","end":"2026-04-21T19:13:07.424879Z","steps":["trace[1717064281] 'process raft request' (duration: 240.529487ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:13:07.425042Z","caller":"traceutil/trace.go:171","msg":"trace[2121694983] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"268.546531ms","start":"2026-04-21T19:13:07.156485Z","end":"2026-04-21T19:13:07.425032Z","steps":["trace[2121694983] 'process raft request' (duration: 267.271238ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:13:07.424678Z","caller":"traceutil/trace.go:171","msg":"trace[475747550] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"275.941453ms","start":"2026-04-21T19:13:07.148713Z","end":"2026-04-21T19:13:07.424655Z","steps":["trace[475747550] 'process raft request' (duration: 274.886188ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:13:07.425098Z","caller":"traceutil/trace.go:171","msg":"trace[904927421] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"260.147358ms","start":"2026-04-21T19:13:07.164935Z","end":"2026-04-21T19:13:07.425083Z","steps":["trace[904927421] 'process raft request' (duration: 259.232695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:09.51424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.113969ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-21T19:13:09.514369Z","caller":"traceutil/trace.go:171","msg":"trace[1676971335] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"774.594512ms","start":"2026-04-21T19:13:08.739758Z","end":"2026-04-21T19:13:09.514352Z","steps":["trace[1676971335] 'read index received' (duration: 355.121665ms)","trace[1676971335] 'applied index is now lower than readState.Index' (duration: 419.471756ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:13:09.51459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.115508ms","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-04-21T19:13:09.514629Z","caller":"traceutil/trace.go:171","msg":"trace[1425686916] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:597; }","duration":"579.201585ms","start":"2026-04-21T19:13:08.935415Z","end":"2026-04-21T19:13:09.514617Z","steps":["trace[1425686916] 'agreement among raft nodes before linearized reading' (duration: 579.039712ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:09.514666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:08.935388Z","time spent":"579.27002ms","remote":"127.0.0.1:39694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-21T19:13:09.514691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.134852ms","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-04-21T19:13:09.514815Z","caller":"traceutil/trace.go:171","msg":"trace[239135061] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:597; }","duration":"536.311376ms","start":"2026-04-21T19:13:08.97848Z","end":"2026-04-21T19:13:09.514791Z","steps":["trace[239135061] 'agreement among raft nodes before linearized reading' (duration: 536.007543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:09.514706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"774.889944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"warn","ts":"2026-04-21T19:13:09.514882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:08.978469Z","time spent":"536.399583ms","remote":"127.0.0.1:39694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-21T19:13:09.51494Z","caller":"traceutil/trace.go:171","msg":"trace[420300577] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:597; }","duration":"775.143694ms","start":"2026-04-21T19:13:08.73973Z","end":"2026-04-21T19:13:09.514874Z","steps":["trace[420300577] 'agreement among raft nodes before linearized reading' (duration: 774.70798ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:09.515077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:08.739721Z","time spent":"775.315767ms","remote":"127.0.0.1:39452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":1,"response size":7730,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-04-21T19:13:09.51506Z","caller":"traceutil/trace.go:171","msg":"trace[898395288] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"792.767818ms","start":"2026-04-21T19:13:08.721647Z","end":"2026-04-21T19:13:09.514415Z","steps":["trace[898395288] 'process raft request' (duration: 373.373148ms)","trace[898395288] 'compare' (duration: 418.944226ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:13:09.515727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:08.721624Z","time spent":"793.993091ms","remote":"127.0.0.1:39452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:13:10.023814Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853969973755301832,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-21T19:13:10.336259Z","caller":"traceutil/trace.go:171","msg":"trace[136282295] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"815.775086ms","start":"2026-04-21T19:13:09.520392Z","end":"2026-04-21T19:13:10.336167Z","steps":["trace[136282295] 'process raft request' (duration: 813.031019ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:10.336526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:09.520361Z","time spent":"816.043116ms","remote":"127.0.0.1:39694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:13:10.353Z","caller":"traceutil/trace.go:171","msg":"trace[535093675] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:622; }","duration":"829.688592ms","start":"2026-04-21T19:13:09.523286Z","end":"2026-04-21T19:13:10.352974Z","steps":["trace[535093675] 'read index received' (duration: 810.242053ms)","trace[535093675] 'applied index is now lower than readState.Index' (duration: 19.445439ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:13:10.353363Z","caller":"traceutil/trace.go:171","msg":"trace[1225158009] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"832.146612ms","start":"2026-04-21T19:13:09.5212Z","end":"2026-04-21T19:13:10.353347Z","steps":["trace[1225158009] 'process raft request' (duration: 831.304609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:10.353514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:09.52119Z","time spent":"832.200796ms","remote":"127.0.0.1:39694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T19:13:10.353978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.510416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:13:10.354021Z","caller":"traceutil/trace.go:171","msg":"trace[1522967520] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:600; }","duration":"772.582701ms","start":"2026-04-21T19:13:09.581424Z","end":"2026-04-21T19:13:10.354007Z","steps":["trace[1522967520] 'agreement among raft nodes before linearized reading' (duration: 772.503975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:10.354044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:09.581417Z","time spent":"772.622455ms","remote":"127.0.0.1:39408","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-04-21T19:13:10.354242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.592881ms","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-04-21T19:13:10.354268Z","caller":"traceutil/trace.go:171","msg":"trace[118573498] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:600; }","duration":"563.665047ms","start":"2026-04-21T19:13:09.790596Z","end":"2026-04-21T19:13:10.354262Z","steps":["trace[118573498] 'agreement among raft nodes before linearized reading' (duration: 563.551839ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:10.354288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:09.790574Z","time spent":"563.70844ms","remote":"127.0.0.1:39694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-21T19:13:10.354269Z","caller":"traceutil/trace.go:171","msg":"trace[1567851224] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"781.160972ms","start":"2026-04-21T19:13:09.573096Z","end":"2026-04-21T19:13:10.354257Z","steps":["trace[1567851224] 'process raft request' (duration: 779.690421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:10.354432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"831.09529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31145"} {"level":"info","ts":"2026-04-21T19:13:10.354549Z","caller":"traceutil/trace.go:171","msg":"trace[27699729] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:600; }","duration":"831.272603ms","start":"2026-04-21T19:13:09.523248Z","end":"2026-04-21T19:13:10.354521Z","steps":["trace[27699729] 'agreement among raft nodes before linearized reading' (duration: 830.888273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:10.354607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:09.523239Z","time spent":"831.357669ms","remote":"127.0.0.1:39452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":31167,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-04-21T19:13:10.354472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:09.573073Z","time spent":"781.305374ms","remote":"127.0.0.1:39452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208470,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:13:12.025346Z","caller":"traceutil/trace.go:171","msg":"trace[1663680838] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"129.610425ms","start":"2026-04-21T19:13:11.895698Z","end":"2026-04-21T19:13:12.025308Z","steps":["trace[1663680838] 'process raft request' (duration: 91.646951ms)","trace[1663680838] 'compare' (duration: 37.795692ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:13:12.452322Z","caller":"traceutil/trace.go:171","msg":"trace[78008241] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:631; }","duration":"110.729866ms","start":"2026-04-21T19:13:12.341541Z","end":"2026-04-21T19:13:12.452271Z","steps":["trace[78008241] 'read index received' (duration: 109.476086ms)","trace[78008241] 'applied index is now lower than readState.Index' (duration: 1.25286ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:13:12.452506Z","caller":"traceutil/trace.go:171","msg":"trace[2097542697] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"159.906361ms","start":"2026-04-21T19:13:12.292557Z","end":"2026-04-21T19:13:12.452463Z","steps":["trace[2097542697] 'process raft request' (duration: 159.107674ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:12.452711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.147288ms","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-04-21T19:13:12.452802Z","caller":"traceutil/trace.go:171","msg":"trace[1323818285] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:607; }","duration":"111.314611ms","start":"2026-04-21T19:13:12.34147Z","end":"2026-04-21T19:13:12.452784Z","steps":["trace[1323818285] 'agreement among raft nodes before linearized reading' (duration: 110.985046ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:13:12.586023Z","caller":"traceutil/trace.go:171","msg":"trace[2006208945] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"128.191857ms","start":"2026-04-21T19:13:12.457804Z","end":"2026-04-21T19:13:12.585996Z","steps":["trace[2006208945] 'process raft request' (duration: 35.548573ms)","trace[2006208945] 'compare' (duration: 92.359523ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:13:12.586114Z","caller":"traceutil/trace.go:171","msg":"trace[24176194] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"127.926508ms","start":"2026-04-21T19:13:12.458159Z","end":"2026-04-21T19:13:12.586085Z","steps":["trace[24176194] 'process raft request' (duration: 127.706092ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:13:12.586564Z","caller":"traceutil/trace.go:171","msg":"trace[711268252] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"127.860052ms","start":"2026-04-21T19:13:12.458694Z","end":"2026-04-21T19:13:12.586554Z","steps":["trace[711268252] 'process raft request' (duration: 127.69021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:15.034709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.730415ms","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-04-21T19:13:15.034802Z","caller":"traceutil/trace.go:171","msg":"trace[262212951] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"113.894057ms","start":"2026-04-21T19:13:14.920888Z","end":"2026-04-21T19:13:15.034782Z","steps":["trace[262212951] 'range keys from in-memory index tree' (duration: 113.555794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:15.035184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.996523ms","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-04-21T19:13:15.035235Z","caller":"traceutil/trace.go:171","msg":"trace[1959397301] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"114.054437ms","start":"2026-04-21T19:13:14.921163Z","end":"2026-04-21T19:13:15.035217Z","steps":["trace[1959397301] 'count revisions from in-memory index tree' (duration: 113.937229ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:13:15.81932Z","caller":"traceutil/trace.go:171","msg":"trace[1465462888] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"496.531252ms","start":"2026-04-21T19:13:15.322754Z","end":"2026-04-21T19:13:15.819285Z","steps":["trace[1465462888] 'read index received' (duration: 495.571557ms)","trace[1465462888] 'applied index is now lower than readState.Index' (duration: 957.945µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:13:15.81937Z","caller":"traceutil/trace.go:171","msg":"trace[1983949682] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"718.076472ms","start":"2026-04-21T19:13:15.101265Z","end":"2026-04-21T19:13:15.819342Z","steps":["trace[1983949682] 'process raft request' (duration: 717.225954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:15.819551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.403333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-21T19:13:15.819562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:15.101221Z","time spent":"718.209991ms","remote":"127.0.0.1:39492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:13:15.819601Z","caller":"traceutil/trace.go:171","msg":"trace[2067575225] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"239.48737ms","start":"2026-04-21T19:13:15.580096Z","end":"2026-04-21T19:13:15.819583Z","steps":["trace[2067575225] 'agreement among raft nodes before linearized reading' (duration: 239.405604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:15.819875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.073239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zstnf\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-21T19:13:15.820031Z","caller":"traceutil/trace.go:171","msg":"trace[1745556430] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zstnf; range_end:; response_count:1; response_revision:627; }","duration":"497.276462ms","start":"2026-04-21T19:13:15.322697Z","end":"2026-04-21T19:13:15.819973Z","steps":["trace[1745556430] 'agreement among raft nodes before linearized reading' (duration: 496.746556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:15.820183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:15.322671Z","time spent":"497.495928ms","remote":"127.0.0.1:39608","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-zstnf\" "} {"level":"info","ts":"2026-04-21T19:13:16.006379Z","caller":"traceutil/trace.go:171","msg":"trace[1963380090] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"166.42714ms","start":"2026-04-21T19:13:15.839903Z","end":"2026-04-21T19:13:16.00633Z","steps":["trace[1963380090] 'process raft request' (duration: 165.915146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:17.08024Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15853969973755301976,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-21T19:13:17.431083Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.425018815s","expected-duration":"1s"} {"level":"info","ts":"2026-04-21T19:13:17.467358Z","caller":"traceutil/trace.go:171","msg":"trace[2023556080] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"887.83272ms","start":"2026-04-21T19:13:16.579506Z","end":"2026-04-21T19:13:17.467339Z","steps":["trace[2023556080] 'read index received' (duration: 851.748264ms)","trace[2023556080] 'applied index is now lower than readState.Index' (duration: 36.083176ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:13:17.467379Z","caller":"traceutil/trace.go:171","msg":"trace[12070944] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"1.590011551s","start":"2026-04-21T19:13:15.87733Z","end":"2026-04-21T19:13:17.467342Z","steps":["trace[12070944] 'process raft request' (duration: 1.554041163s)","trace[12070944] 'compare' (duration: 35.661407ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:13:17.467485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:15.877297Z","time spent":"1.590126409s","remote":"127.0.0.1:39794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-21T19:13:17.467569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"850.519854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-21T19:13:17.467548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"888.019383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:13:17.4676Z","caller":"traceutil/trace.go:171","msg":"trace[989550122] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:629; }","duration":"850.60435ms","start":"2026-04-21T19:13:16.616989Z","end":"2026-04-21T19:13:17.467593Z","steps":["trace[989550122] 'agreement among raft nodes before linearized reading' (duration: 850.44974ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:17.467626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:16.616968Z","time spent":"850.652503ms","remote":"127.0.0.1:39694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-21T19:13:17.467631Z","caller":"traceutil/trace.go:171","msg":"trace[676458621] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"888.144681ms","start":"2026-04-21T19:13:16.579465Z","end":"2026-04-21T19:13:17.467609Z","steps":["trace[676458621] 'agreement among raft nodes before linearized reading' (duration: 887.933257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:17.467673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:16.579447Z","time spent":"888.218476ms","remote":"127.0.0.1:39408","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-04-21T19:13:17.467775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.632244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-21T19:13:17.467801Z","caller":"traceutil/trace.go:171","msg":"trace[822137760] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:629; }","duration":"849.684428ms","start":"2026-04-21T19:13:16.618109Z","end":"2026-04-21T19:13:17.467793Z","steps":["trace[822137760] 'agreement among raft nodes before linearized reading' (duration: 849.613613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:17.467751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"847.979913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-21T19:13:17.467819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:16.618088Z","time spent":"849.72655ms","remote":"127.0.0.1:39694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-21T19:13:17.467843Z","caller":"traceutil/trace.go:171","msg":"trace[80265796] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:629; }","duration":"848.125303ms","start":"2026-04-21T19:13:16.6197Z","end":"2026-04-21T19:13:17.467825Z","steps":["trace[80265796] 'agreement among raft nodes before linearized reading' (duration: 847.757849ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:17.46792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:16.619672Z","time spent":"848.23779ms","remote":"127.0.0.1:39694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-21T19:13:17.467845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"850.661433ms","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-04-21T19:13:17.46814Z","caller":"traceutil/trace.go:171","msg":"trace[1600974013] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:629; }","duration":"850.970214ms","start":"2026-04-21T19:13:16.617155Z","end":"2026-04-21T19:13:17.468125Z","steps":["trace[1600974013] 'agreement among raft nodes before linearized reading' (duration: 850.60752ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:17.468206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:16.617145Z","time spent":"851.044838ms","remote":"127.0.0.1:39694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-21T19:13:18.801996Z","caller":"traceutil/trace.go:171","msg":"trace[1953669252] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:669; }","duration":"219.249763ms","start":"2026-04-21T19:13:18.582711Z","end":"2026-04-21T19:13:18.801961Z","steps":["trace[1953669252] 'read index received' (duration: 217.842672ms)","trace[1953669252] 'applied index is now lower than readState.Index' (duration: 1.405721ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:13:18.802066Z","caller":"traceutil/trace.go:171","msg":"trace[1961482416] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"330.347325ms","start":"2026-04-21T19:13:18.471663Z","end":"2026-04-21T19:13:18.802011Z","steps":["trace[1961482416] 'process raft request' (duration: 328.921723ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:18.802276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.537311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T19:13:18.80234Z","caller":"traceutil/trace.go:171","msg":"trace[924181973] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"219.698962ms","start":"2026-04-21T19:13:18.582621Z","end":"2026-04-21T19:13:18.80232Z","steps":["trace[924181973] 'agreement among raft nodes before linearized reading' (duration: 219.532202ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:18.802624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:18.47161Z","time spent":"330.592991ms","remote":"127.0.0.1:39660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T19:13:33.500603Z","caller":"traceutil/trace.go:171","msg":"trace[1999952488] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"401.746324ms","start":"2026-04-21T19:13:33.098823Z","end":"2026-04-21T19:13:33.500569Z","steps":["trace[1999952488] 'process raft request' (duration: 401.530213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:13:33.500815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T19:13:33.098803Z","time spent":"401.89749ms","remote":"127.0.0.1:39694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-21T19:14:56.259854Z","caller":"traceutil/trace.go:171","msg":"trace[1923626031] linearizableReadLoop","detail":"{readStateIndex:1249; appliedIndex:1248; }","duration":"247.681097ms","start":"2026-04-21T19:14:56.012146Z","end":"2026-04-21T19:14:56.259827Z","steps":["trace[1923626031] 'read index received' (duration: 247.113897ms)","trace[1923626031] 'applied index is now lower than readState.Index' (duration: 566.23µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T19:14:56.261136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.976948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:503"} {"level":"info","ts":"2026-04-21T19:14:56.261179Z","caller":"traceutil/trace.go:171","msg":"trace[948440064] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1200; }","duration":"249.102418ms","start":"2026-04-21T19:14:56.012069Z","end":"2026-04-21T19:14:56.261171Z","steps":["trace[948440064] 'agreement among raft nodes before linearized reading' (duration: 247.866567ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:14:56.26234Z","caller":"traceutil/trace.go:171","msg":"trace[451604434] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"294.134363ms","start":"2026-04-21T19:14:55.968189Z","end":"2026-04-21T19:14:56.262323Z","steps":["trace[451604434] 'process raft request' (duration: 291.154782ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:15:14.607989Z","caller":"traceutil/trace.go:171","msg":"trace[1046363740] linearizableReadLoop","detail":"{readStateIndex:1316; appliedIndex:1313; }","duration":"140.92984ms","start":"2026-04-21T19:15:14.467035Z","end":"2026-04-21T19:15:14.607965Z","steps":["trace[1046363740] 'read index received' (duration: 21.071039ms)","trace[1046363740] 'applied index is now lower than readState.Index' (duration: 119.857911ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T19:15:14.608038Z","caller":"traceutil/trace.go:171","msg":"trace[2030428069] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"147.766562ms","start":"2026-04-21T19:15:14.460239Z","end":"2026-04-21T19:15:14.608005Z","steps":["trace[2030428069] 'process raft request' (duration: 147.551543ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T19:15:14.608073Z","caller":"traceutil/trace.go:171","msg":"trace[829941420] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"147.426404ms","start":"2026-04-21T19:15:14.460609Z","end":"2026-04-21T19:15:14.608035Z","steps":["trace[829941420] 'process raft request' (duration: 147.314934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T19:15:14.608251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.197789ms","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-04-21T19:15:14.608368Z","caller":"traceutil/trace.go:171","msg":"trace[1323786404] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1263; }","duration":"141.331398ms","start":"2026-04-21T19:15:14.467018Z","end":"2026-04-21T19:15:14.60835Z","steps":["trace[1323786404] 'agreement among raft nodes before linearized reading' (duration: 141.079729ms)"],"step_count":1}