{"level":"warn","ts":"2026-06-23T22:07:51.405928Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-23T22:07:51.406051Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.162: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.162:2380","--initial-cluster=instance=https://199.204.45.162:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.162:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.162:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-23T22:07:51.406241Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-23T22:07:51.406265Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-06-23T22:07:51.406297Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-23T22:07:51.407381Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"]} {"level":"info","ts":"2026-06-23T22:07:51.40757Z","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.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.162:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-23T22:07:51.458546Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"50.081949ms"} {"level":"info","ts":"2026-06-23T22:07:51.47523Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2d372260bb4c37a","cluster-id":"52bb6ec15e8722ff"} {"level":"info","ts":"2026-06-23T22:07:51.475301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=()"} {"level":"info","ts":"2026-06-23T22:07:51.475329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 0"} {"level":"info","ts":"2026-06-23T22:07:51.475349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2d372260bb4c37a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-23T22:07:51.475362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 1"} {"level":"info","ts":"2026-06-23T22:07:51.475399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"warn","ts":"2026-06-23T22:07:51.48688Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-23T22:07:51.491444Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-23T22:07:51.493124Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-23T22:07:51.496349Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2d372260bb4c37a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-23T22:07:51.496484Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2d372260bb4c37a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-23T22:07:51.497515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"info","ts":"2026-06-23T22:07:51.497647Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","added-peer-id":"2d372260bb4c37a","added-peer-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-06-23T22:07:51.497716Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-23T22:07:51.497792Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-23T22:07:51.497808Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-23T22:07:51.499926Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-23T22:07:51.500069Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-06-23T22:07:51.500079Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-06-23T22:07:51.500973Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2d372260bb4c37a","initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-23T22:07:51.501027Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-23T22:07:51.975697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a is starting a new election at term 1"} {"level":"info","ts":"2026-06-23T22:07:51.975775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became pre-candidate at term 1"} {"level":"info","ts":"2026-06-23T22:07:51.9758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgPreVoteResp from 2d372260bb4c37a at term 1"} {"level":"info","ts":"2026-06-23T22:07:51.975819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became candidate at term 2"} {"level":"info","ts":"2026-06-23T22:07:51.975829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgVoteResp from 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-06-23T22:07:51.975844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became leader at term 2"} {"level":"info","ts":"2026-06-23T22:07:51.975857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2d372260bb4c37a elected leader 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-06-23T22:07:51.976635Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T22:07:51.977989Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2d372260bb4c37a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.162:2379]}","request-path":"/0/members/2d372260bb4c37a/attributes","cluster-id":"52bb6ec15e8722ff","publish-timeout":"7s"} {"level":"info","ts":"2026-06-23T22:07:51.978048Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-23T22:07:51.97817Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-23T22:07:51.980387Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-23T22:07:51.980605Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-23T22:07:51.98063Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-23T22:07:51.988337Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T22:07:51.995041Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T22:07:51.995181Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T22:07:51.996777Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.162:2379"} {"level":"info","ts":"2026-06-23T22:07:54.703035Z","caller":"traceutil/trace.go:171","msg":"trace[503387099] transaction","detail":"{read_only:false; response_revision:84; number_of_response:1; }","duration":"165.655505ms","start":"2026-06-23T22:07:54.537351Z","end":"2026-06-23T22:07:54.703007Z","steps":["trace[503387099] 'process raft request' (duration: 89.042185ms)","trace[503387099] 'compare' (duration: 76.419792ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:07:55.141906Z","caller":"traceutil/trace.go:171","msg":"trace[517339889] linearizableReadLoop","detail":"{readStateIndex:106; appliedIndex:105; }","duration":"177.523001ms","start":"2026-06-23T22:07:54.964353Z","end":"2026-06-23T22:07:55.141876Z","steps":["trace[517339889] 'read index received' (duration: 49.012µs)","trace[517339889] 'applied index is now lower than readState.Index' (duration: 177.472219ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:07:55.14199Z","caller":"traceutil/trace.go:171","msg":"trace[870073642] transaction","detail":"{read_only:false; response_revision:101; number_of_response:1; }","duration":"177.606914ms","start":"2026-06-23T22:07:54.964329Z","end":"2026-06-23T22:07:55.141936Z","steps":["trace[870073642] 'process raft request' (duration: 82.205827ms)","trace[870073642] 'compare' (duration: 95.21397ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:07:55.142195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.75917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:nodeclient\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-23T22:07:55.142309Z","caller":"traceutil/trace.go:171","msg":"trace[14484364] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:certificatesigningrequests:nodeclient; range_end:; response_count:0; response_revision:101; }","duration":"177.921427ms","start":"2026-06-23T22:07:54.964345Z","end":"2026-06-23T22:07:55.142266Z","steps":["trace[14484364] 'agreement among raft nodes before linearized reading' (duration: 177.641375ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:07:56.499732Z","caller":"traceutil/trace.go:171","msg":"trace[1964523674] transaction","detail":"{read_only:false; response_revision:229; number_of_response:1; }","duration":"143.430215ms","start":"2026-06-23T22:07:56.356234Z","end":"2026-06-23T22:07:56.499665Z","steps":["trace[1964523674] 'process raft request' (duration: 113.331212ms)","trace[1964523674] 'compare' (duration: 29.941716ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:07:59.107453Z","caller":"traceutil/trace.go:171","msg":"trace[1317808432] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"122.322947ms","start":"2026-06-23T22:07:58.985073Z","end":"2026-06-23T22:07:59.107396Z","steps":["trace[1317808432] 'process raft request' (duration: 28.246229ms)","trace[1317808432] 'compare' (duration: 93.931303ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:07:59.112454Z","caller":"traceutil/trace.go:171","msg":"trace[1785036766] linearizableReadLoop","detail":"{readStateIndex:303; appliedIndex:301; }","duration":"121.674131ms","start":"2026-06-23T22:07:58.990758Z","end":"2026-06-23T22:07:59.112432Z","steps":["trace[1785036766] 'read index received' (duration: 22.56834ms)","trace[1785036766] 'applied index is now lower than readState.Index' (duration: 99.104781ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:07:59.112609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.825507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T22:07:59.112589Z","caller":"traceutil/trace.go:171","msg":"trace[1367468727] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"120.800257ms","start":"2026-06-23T22:07:58.991762Z","end":"2026-06-23T22:07:59.112562Z","steps":["trace[1367468727] 'process raft request' (duration: 120.63204ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:07:59.112631Z","caller":"traceutil/trace.go:171","msg":"trace[799951702] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"125.132584ms","start":"2026-06-23T22:07:58.987472Z","end":"2026-06-23T22:07:59.112605Z","steps":["trace[799951702] 'process raft request' (duration: 124.806552ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:07:59.112649Z","caller":"traceutil/trace.go:171","msg":"trace[1022606424] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:0; response_revision:298; }","duration":"121.90225ms","start":"2026-06-23T22:07:58.990734Z","end":"2026-06-23T22:07:59.112637Z","steps":["trace[1022606424] 'agreement among raft nodes before linearized reading' (duration: 121.805286ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:07:59.318746Z","caller":"traceutil/trace.go:171","msg":"trace[145068654] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"174.222132ms","start":"2026-06-23T22:07:59.144506Z","end":"2026-06-23T22:07:59.318728Z","steps":["trace[145068654] 'process raft request' (duration: 174.187781ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:07:59.318841Z","caller":"traceutil/trace.go:171","msg":"trace[767438406] linearizableReadLoop","detail":"{readStateIndex:313; appliedIndex:311; }","duration":"186.165349ms","start":"2026-06-23T22:07:59.132653Z","end":"2026-06-23T22:07:59.318818Z","steps":["trace[767438406] 'read index received' (duration: 10.601155ms)","trace[767438406] 'applied index is now lower than readState.Index' (duration: 175.561494ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:07:59.318885Z","caller":"traceutil/trace.go:171","msg":"trace[436781928] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"185.321877ms","start":"2026-06-23T22:07:59.13353Z","end":"2026-06-23T22:07:59.318852Z","steps":["trace[436781928] 'process raft request' (duration: 185.12348ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:07:59.318897Z","caller":"traceutil/trace.go:171","msg":"trace[1193534925] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"185.413581ms","start":"2026-06-23T22:07:59.133458Z","end":"2026-06-23T22:07:59.318872Z","steps":["trace[1193534925] 'process raft request' (duration: 185.143081ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:07:59.319037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.840131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-23T22:07:59.318732Z","caller":"traceutil/trace.go:171","msg":"trace[802282706] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"186.106917ms","start":"2026-06-23T22:07:59.13259Z","end":"2026-06-23T22:07:59.318697Z","steps":["trace[802282706] 'process raft request' (duration: 105.073378ms)","trace[802282706] 'compare' (duration: 80.825501ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:07:59.319102Z","caller":"traceutil/trace.go:171","msg":"trace[915913810] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:306; }","duration":"126.940674ms","start":"2026-06-23T22:07:59.192146Z","end":"2026-06-23T22:07:59.319086Z","steps":["trace[915913810] 'agreement among raft nodes before linearized reading' (duration: 126.811029ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:07:59.319064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.365417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-06-23T22:07:59.319631Z","caller":"traceutil/trace.go:171","msg":"trace[1311963611] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:306; }","duration":"186.97158ms","start":"2026-06-23T22:07:59.132608Z","end":"2026-06-23T22:07:59.31958Z","steps":["trace[1311963611] 'agreement among raft nodes before linearized reading' (duration: 186.324105ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:07:59.486564Z","caller":"traceutil/trace.go:171","msg":"trace[982531034] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"161.093181ms","start":"2026-06-23T22:07:59.325438Z","end":"2026-06-23T22:07:59.486531Z","steps":["trace[982531034] 'process raft request' (duration: 146.253794ms)","trace[982531034] 'compare' (duration: 14.6511ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:07:59.486733Z","caller":"traceutil/trace.go:171","msg":"trace[1840421152] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"160.902644ms","start":"2026-06-23T22:07:59.325784Z","end":"2026-06-23T22:07:59.486687Z","steps":["trace[1840421152] 'process raft request' (duration: 160.711027ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:07:59.486587Z","caller":"traceutil/trace.go:171","msg":"trace[112645669] linearizableReadLoop","detail":"{readStateIndex:321; appliedIndex:317; }","duration":"121.451405ms","start":"2026-06-23T22:07:59.365117Z","end":"2026-06-23T22:07:59.486568Z","steps":["trace[112645669] 'read index received' (duration: 106.519073ms)","trace[112645669] 'applied index is now lower than readState.Index' (duration: 14.931242ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:07:59.486792Z","caller":"traceutil/trace.go:171","msg":"trace[1203516610] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"156.571998ms","start":"2026-06-23T22:07:59.330083Z","end":"2026-06-23T22:07:59.486655Z","steps":["trace[1203516610] 'process raft request' (duration: 156.444043ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:07:59.486604Z","caller":"traceutil/trace.go:171","msg":"trace[693288969] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"160.79839ms","start":"2026-06-23T22:07:59.325785Z","end":"2026-06-23T22:07:59.486583Z","steps":["trace[693288969] 'process raft request' (duration: 160.662095ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:07:59.487297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.162113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-06-23T22:07:59.487346Z","caller":"traceutil/trace.go:171","msg":"trace[265705379] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:311; }","duration":"122.252666ms","start":"2026-06-23T22:07:59.365082Z","end":"2026-06-23T22:07:59.487334Z","steps":["trace[265705379] 'agreement among raft nodes before linearized reading' (duration: 121.544309ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:07:59.732978Z","caller":"traceutil/trace.go:171","msg":"trace[711316792] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"141.523862ms","start":"2026-06-23T22:07:59.591419Z","end":"2026-06-23T22:07:59.732943Z","steps":["trace[711316792] 'process raft request' (duration: 141.47356ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:07:59.733003Z","caller":"traceutil/trace.go:171","msg":"trace[2064479082] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"155.094531ms","start":"2026-06-23T22:07:59.577871Z","end":"2026-06-23T22:07:59.732965Z","steps":["trace[2064479082] 'process raft request' (duration: 85.836263ms)","trace[2064479082] 'compare' (duration: 68.994208ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:08:02.396182Z","caller":"traceutil/trace.go:171","msg":"trace[892776961] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"140.198526ms","start":"2026-06-23T22:08:02.255961Z","end":"2026-06-23T22:08:02.39616Z","steps":["trace[892776961] 'process raft request' (duration: 140.137544ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:02.396291Z","caller":"traceutil/trace.go:171","msg":"trace[264471933] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"141.1074ms","start":"2026-06-23T22:08:02.255141Z","end":"2026-06-23T22:08:02.396248Z","steps":["trace[264471933] 'process raft request' (duration: 92.61233ms)","trace[264471933] 'compare' (duration: 48.240431ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:08:02.39951Z","caller":"traceutil/trace.go:171","msg":"trace[169528247] linearizableReadLoop","detail":"{readStateIndex:381; appliedIndex:378; }","duration":"106.563314ms","start":"2026-06-23T22:08:02.292932Z","end":"2026-06-23T22:08:02.399495Z","steps":["trace[169528247] 'read index received' (duration: 54.817964ms)","trace[169528247] 'applied index is now lower than readState.Index' (duration: 51.7441ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:08:02.399753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.799012ms","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":"info","ts":"2026-06-23T22:08:02.399847Z","caller":"traceutil/trace.go:171","msg":"trace[1935716609] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:368; }","duration":"106.928397ms","start":"2026-06-23T22:08:02.2929Z","end":"2026-06-23T22:08:02.399829Z","steps":["trace[1935716609] 'agreement among raft nodes before linearized reading' (duration: 106.716449ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:02.399762Z","caller":"traceutil/trace.go:171","msg":"trace[1159876805] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"136.407246ms","start":"2026-06-23T22:08:02.263328Z","end":"2026-06-23T22:08:02.399735Z","steps":["trace[1159876805] 'process raft request' (duration: 136.104245ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:14.899768Z","caller":"traceutil/trace.go:171","msg":"trace[911037488] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"859.614575ms","start":"2026-06-23T22:08:14.040131Z","end":"2026-06-23T22:08:14.899745Z","steps":["trace[911037488] 'process raft request' (duration: 859.46443ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:14.900415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:14.040113Z","time spent":"859.731179ms","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T22:08:14.905225Z","caller":"traceutil/trace.go:171","msg":"trace[428306351] linearizableReadLoop","detail":"{readStateIndex:441; appliedIndex:439; }","duration":"359.221269ms","start":"2026-06-23T22:08:14.545978Z","end":"2026-06-23T22:08:14.905199Z","steps":["trace[428306351] 'read index received' (duration: 353.65133ms)","trace[428306351] 'applied index is now lower than readState.Index' (duration: 5.569229ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:08:14.905339Z","caller":"traceutil/trace.go:171","msg":"trace[1269722139] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"832.382168ms","start":"2026-06-23T22:08:14.072901Z","end":"2026-06-23T22:08:14.905283Z","steps":["trace[1269722139] 'process raft request' (duration: 832.13893ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:14.905409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.391064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T22:08:14.905533Z","caller":"traceutil/trace.go:171","msg":"trace[1312285281] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:425; }","duration":"359.57068ms","start":"2026-06-23T22:08:14.545932Z","end":"2026-06-23T22:08:14.905503Z","steps":["trace[1312285281] 'agreement among raft nodes before linearized reading' (duration: 359.365573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:14.905579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:14.072879Z","time spent":"832.584464ms","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T22:08:14.905598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:14.545914Z","time spent":"359.668643ms","remote":"127.0.0.1:47236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-23T22:08:17.490098Z","caller":"traceutil/trace.go:171","msg":"trace[1064954027] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"171.758062ms","start":"2026-06-23T22:08:17.31831Z","end":"2026-06-23T22:08:17.490068Z","steps":["trace[1064954027] 'process raft request' (duration: 96.894359ms)","trace[1064954027] 'compare' (duration: 74.636706ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:08:17.490143Z","caller":"traceutil/trace.go:171","msg":"trace[501341351] linearizableReadLoop","detail":"{readStateIndex:458; appliedIndex:454; }","duration":"116.703837ms","start":"2026-06-23T22:08:17.37342Z","end":"2026-06-23T22:08:17.490124Z","steps":["trace[501341351] 'read index received' (duration: 41.800333ms)","trace[501341351] 'applied index is now lower than readState.Index' (duration: 74.902554ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:08:17.490234Z","caller":"traceutil/trace.go:171","msg":"trace[1171023855] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"168.733457ms","start":"2026-06-23T22:08:17.321446Z","end":"2026-06-23T22:08:17.49018Z","steps":["trace[1171023855] 'process raft request' (duration: 168.588483ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:17.4903Z","caller":"traceutil/trace.go:171","msg":"trace[44384429] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"168.531541ms","start":"2026-06-23T22:08:17.321729Z","end":"2026-06-23T22:08:17.490261Z","steps":["trace[44384429] 'process raft request' (duration: 168.362416ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:17.490409Z","caller":"traceutil/trace.go:171","msg":"trace[299768562] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"171.932757ms","start":"2026-06-23T22:08:17.318376Z","end":"2026-06-23T22:08:17.490309Z","steps":["trace[299768562] 'process raft request' (duration: 171.616098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:17.490959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.526622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-9mg25\" ","response":"range_response_count:1 size:4016"} {"level":"info","ts":"2026-06-23T22:08:17.491093Z","caller":"traceutil/trace.go:171","msg":"trace[677576754] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-9mg25; range_end:; response_count:1; response_revision:441; }","duration":"117.700717ms","start":"2026-06-23T22:08:17.373373Z","end":"2026-06-23T22:08:17.491073Z","steps":["trace[677576754] 'agreement among raft nodes before linearized reading' (duration: 117.489341ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:17.525158Z","caller":"traceutil/trace.go:171","msg":"trace[1067638635] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"150.83962ms","start":"2026-06-23T22:08:17.3743Z","end":"2026-06-23T22:08:17.525139Z","steps":["trace[1067638635] 'process raft request' (duration: 150.729036ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:17.525261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.264483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-23T22:08:17.525275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.528218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-06-23T22:08:17.525348Z","caller":"traceutil/trace.go:171","msg":"trace[1489997797] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:442; }","duration":"107.391606ms","start":"2026-06-23T22:08:17.41794Z","end":"2026-06-23T22:08:17.525332Z","steps":["trace[1489997797] 'agreement among raft nodes before linearized reading' (duration: 107.2153ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:17.525359Z","caller":"traceutil/trace.go:171","msg":"trace[1384390151] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:442; }","duration":"148.677563ms","start":"2026-06-23T22:08:17.376664Z","end":"2026-06-23T22:08:17.525342Z","steps":["trace[1384390151] 'agreement among raft nodes before linearized reading' (duration: 148.479427ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:17.689652Z","caller":"traceutil/trace.go:171","msg":"trace[2123829232] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"195.599475ms","start":"2026-06-23T22:08:17.49399Z","end":"2026-06-23T22:08:17.689589Z","steps":["trace[2123829232] 'process raft request' (duration: 148.643742ms)","trace[2123829232] 'compare' (duration: 46.691755ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:08:17.689988Z","caller":"traceutil/trace.go:171","msg":"trace[141206263] linearizableReadLoop","detail":"{readStateIndex:463; appliedIndex:459; }","duration":"143.792121ms","start":"2026-06-23T22:08:17.546175Z","end":"2026-06-23T22:08:17.689967Z","steps":["trace[141206263] 'read index received' (duration: 96.560639ms)","trace[141206263] 'applied index is now lower than readState.Index' (duration: 47.230412ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:08:17.6901Z","caller":"traceutil/trace.go:171","msg":"trace[631401702] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"160.600055ms","start":"2026-06-23T22:08:17.529488Z","end":"2026-06-23T22:08:17.690088Z","steps":["trace[631401702] 'process raft request' (duration: 160.314586ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:17.690148Z","caller":"traceutil/trace.go:171","msg":"trace[2052040117] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"193.284153ms","start":"2026-06-23T22:08:17.49685Z","end":"2026-06-23T22:08:17.690134Z","steps":["trace[2052040117] 'process raft request' (duration: 192.603442ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:17.69016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.971456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T22:08:17.690416Z","caller":"traceutil/trace.go:171","msg":"trace[2017368789] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:445; }","duration":"144.259655ms","start":"2026-06-23T22:08:17.54613Z","end":"2026-06-23T22:08:17.69039Z","steps":["trace[2017368789] 'agreement among raft nodes before linearized reading' (duration: 143.977356ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:17.69057Z","caller":"traceutil/trace.go:171","msg":"trace[715591116] transaction","detail":"{read_only:false; number_of_response:1; response_revision:445; }","duration":"156.555748ms","start":"2026-06-23T22:08:17.534003Z","end":"2026-06-23T22:08:17.690558Z","steps":["trace[715591116] 'process raft request' (duration: 155.910548ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:17.690576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.189951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-23T22:08:17.690614Z","caller":"traceutil/trace.go:171","msg":"trace[518202648] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:445; }","duration":"117.278465ms","start":"2026-06-23T22:08:17.573325Z","end":"2026-06-23T22:08:17.690603Z","steps":["trace[518202648] 'agreement among raft nodes before linearized reading' (duration: 117.199792ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:17.690741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.026155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-23T22:08:17.690768Z","caller":"traceutil/trace.go:171","msg":"trace[1988638635] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:445; }","duration":"116.109607ms","start":"2026-06-23T22:08:17.57465Z","end":"2026-06-23T22:08:17.69076Z","steps":["trace[1988638635] 'agreement among raft nodes before linearized reading' (duration: 116.062846ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:18.156689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.621584ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-23T22:08:18.156876Z","caller":"traceutil/trace.go:171","msg":"trace[870447588] linearizableReadLoop","detail":"{readStateIndex:467; appliedIndex:463; }","duration":"460.687964ms","start":"2026-06-23T22:08:17.696175Z","end":"2026-06-23T22:08:18.156863Z","steps":["trace[870447588] 'read index received' (duration: 13.513141ms)","trace[870447588] 'applied index is now lower than readState.Index' (duration: 447.173743ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:08:18.156861Z","caller":"traceutil/trace.go:171","msg":"trace[1328132741] transaction","detail":"{read_only:false; number_of_response:1; response_revision:447; }","duration":"460.223379ms","start":"2026-06-23T22:08:17.69659Z","end":"2026-06-23T22:08:18.156814Z","steps":["trace[1328132741] 'process raft request' (duration: 170.263956ms)","trace[1328132741] 'compare' (duration: 289.510039ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:08:18.156936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.823638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T22:08:18.156954Z","caller":"traceutil/trace.go:171","msg":"trace[675518068] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:450; }","duration":"460.842818ms","start":"2026-06-23T22:08:17.696105Z","end":"2026-06-23T22:08:18.156948Z","steps":["trace[675518068] 'agreement among raft nodes before linearized reading' (duration: 460.795097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:18.156974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:17.695951Z","time spent":"461.018354ms","remote":"127.0.0.1:47240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-23T22:08:18.157012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:17.696557Z","time spent":"460.366674ms","remote":"127.0.0.1:47436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":55,"response count":0,"response size":40,"request content":"compare: success: > failure: >"} {"level":"info","ts":"2026-06-23T22:08:18.157191Z","caller":"traceutil/trace.go:171","msg":"trace[78862129] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"460.098875ms","start":"2026-06-23T22:08:17.697084Z","end":"2026-06-23T22:08:18.157183Z","steps":["trace[78862129] 'process raft request' (duration: 459.679912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:18.157239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:17.697072Z","time spent":"460.142567ms","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T22:08:18.1573Z","caller":"traceutil/trace.go:171","msg":"trace[68067943] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"454.053197ms","start":"2026-06-23T22:08:17.703233Z","end":"2026-06-23T22:08:18.157286Z","steps":["trace[68067943] 'process raft request' (duration: 453.595953ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:18.157386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:17.703207Z","time spent":"454.126869ms","remote":"127.0.0.1:47768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3840,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T22:08:18.157745Z","caller":"traceutil/trace.go:171","msg":"trace[372636936] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"458.774024ms","start":"2026-06-23T22:08:17.698963Z","end":"2026-06-23T22:08:18.157737Z","steps":["trace[372636936] 'process raft request' (duration: 457.844255ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:18.157789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:17.698949Z","time spent":"458.819205ms","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T22:08:24.297915Z","caller":"traceutil/trace.go:171","msg":"trace[117079731] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"115.54215ms","start":"2026-06-23T22:08:24.182348Z","end":"2026-06-23T22:08:24.29789Z","steps":["trace[117079731] 'process raft request' (duration: 115.400445ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:24.649814Z","caller":"traceutil/trace.go:171","msg":"trace[1953932894] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"467.289586ms","start":"2026-06-23T22:08:24.182495Z","end":"2026-06-23T22:08:24.649785Z","steps":["trace[1953932894] 'process raft request' (duration: 467.08483ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:24.649897Z","caller":"traceutil/trace.go:171","msg":"trace[1718890257] linearizableReadLoop","detail":"{readStateIndex:495; appliedIndex:495; }","duration":"104.973604ms","start":"2026-06-23T22:08:24.544886Z","end":"2026-06-23T22:08:24.64986Z","steps":["trace[1718890257] 'read index received' (duration: 104.958154ms)","trace[1718890257] 'applied index is now lower than readState.Index' (duration: 13.02µs)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:08:24.649964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:24.182478Z","time spent":"467.409509ms","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T22:08:24.650109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.19257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T22:08:24.650148Z","caller":"traceutil/trace.go:171","msg":"trace[1470909329] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:476; }","duration":"105.301843ms","start":"2026-06-23T22:08:24.544834Z","end":"2026-06-23T22:08:24.650136Z","steps":["trace[1470909329] 'agreement among raft nodes before linearized reading' (duration: 105.165489ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:26.965828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.568184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-23T22:08:26.965909Z","caller":"traceutil/trace.go:171","msg":"trace[437661421] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:481; }","duration":"237.697098ms","start":"2026-06-23T22:08:26.728195Z","end":"2026-06-23T22:08:26.965892Z","steps":["trace[437661421] 'range keys from in-memory index tree' (duration: 237.42347ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:27.208306Z","caller":"traceutil/trace.go:171","msg":"trace[1111650577] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"159.442276ms","start":"2026-06-23T22:08:27.04883Z","end":"2026-06-23T22:08:27.208272Z","steps":["trace[1111650577] 'process raft request' (duration: 149.346943ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:27.228627Z","caller":"traceutil/trace.go:171","msg":"trace[717048444] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"177.303846ms","start":"2026-06-23T22:08:27.051287Z","end":"2026-06-23T22:08:27.228591Z","steps":["trace[717048444] 'process raft request' (duration: 177.12146ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:28.79549Z","caller":"traceutil/trace.go:171","msg":"trace[2055396248] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"108.136898ms","start":"2026-06-23T22:08:28.687321Z","end":"2026-06-23T22:08:28.795458Z","steps":["trace[2055396248] 'process raft request' (duration: 107.726436ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:28.822123Z","caller":"traceutil/trace.go:171","msg":"trace[515359325] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"133.918252ms","start":"2026-06-23T22:08:28.68818Z","end":"2026-06-23T22:08:28.822098Z","steps":["trace[515359325] 'process raft request' (duration: 133.798979ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:30.501851Z","caller":"traceutil/trace.go:171","msg":"trace[1015948118] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"154.339811ms","start":"2026-06-23T22:08:30.347492Z","end":"2026-06-23T22:08:30.501832Z","steps":["trace[1015948118] 'process raft request' (duration: 154.234268ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:31.050644Z","caller":"traceutil/trace.go:171","msg":"trace[1264408263] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"536.491807ms","start":"2026-06-23T22:08:30.514126Z","end":"2026-06-23T22:08:31.050618Z","steps":["trace[1264408263] 'process raft request' (duration: 536.371854ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:31.050788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:30.514096Z","time spent":"536.628001ms","remote":"127.0.0.1:47310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-23T22:08:31.084033Z","caller":"traceutil/trace.go:171","msg":"trace[870918302] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"567.439348ms","start":"2026-06-23T22:08:30.516562Z","end":"2026-06-23T22:08:31.084001Z","steps":["trace[870918302] 'process raft request' (duration: 567.176461ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:31.084131Z","caller":"traceutil/trace.go:171","msg":"trace[567063425] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"560.15658ms","start":"2026-06-23T22:08:30.523949Z","end":"2026-06-23T22:08:31.084105Z","steps":["trace[567063425] 'process raft request' (duration: 559.990046ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:31.084272Z","caller":"traceutil/trace.go:171","msg":"trace[57490276] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"565.331421ms","start":"2026-06-23T22:08:30.518737Z","end":"2026-06-23T22:08:31.084068Z","steps":["trace[57490276] 'process raft request' (duration: 565.130256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:31.084361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:30.523941Z","time spent":"560.322874ms","remote":"127.0.0.1:47310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-23T22:08:31.084402Z","caller":"traceutil/trace.go:171","msg":"trace[296566186] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"560.097859ms","start":"2026-06-23T22:08:30.524077Z","end":"2026-06-23T22:08:31.084174Z","steps":["trace[296566186] 'process raft request' (duration: 559.921884ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:31.084534Z","caller":"traceutil/trace.go:171","msg":"trace[89529674] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"557.845797ms","start":"2026-06-23T22:08:30.526673Z","end":"2026-06-23T22:08:31.084519Z","steps":["trace[89529674] 'process raft request' (duration: 557.461677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:31.084176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:30.516532Z","time spent":"567.580051ms","remote":"127.0.0.1:47310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-23T22:08:31.084558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:30.518729Z","time spent":"565.68462ms","remote":"127.0.0.1:47310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-23T22:08:31.084308Z","caller":"traceutil/trace.go:171","msg":"trace[395604163] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"558.557517ms","start":"2026-06-23T22:08:30.525716Z","end":"2026-06-23T22:08:31.084274Z","steps":["trace[395604163] 'process raft request' (duration: 558.338661ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:31.08476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:30.525694Z","time spent":"559.02758ms","remote":"127.0.0.1:47310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-23T22:08:31.084635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:30.526667Z","time spent":"557.919859ms","remote":"127.0.0.1:47310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-23T22:08:31.084792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:30.524049Z","time spent":"560.552692ms","remote":"127.0.0.1:47310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-23T22:08:31.08612Z","caller":"traceutil/trace.go:171","msg":"trace[1002435367] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"553.762186ms","start":"2026-06-23T22:08:30.531499Z","end":"2026-06-23T22:08:31.085261Z","steps":["trace[1002435367] 'process raft request' (duration: 552.981145ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:31.086317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:30.531493Z","time spent":"554.723282ms","remote":"127.0.0.1:47310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-23T22:08:31.088447Z","caller":"traceutil/trace.go:171","msg":"trace[1003283673] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"554.519116ms","start":"2026-06-23T22:08:30.533883Z","end":"2026-06-23T22:08:31.088402Z","steps":["trace[1003283673] 'process raft request' (duration: 551.188576ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:31.088775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:30.533874Z","time spent":"554.851675ms","remote":"127.0.0.1:47310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-23T22:08:31.094361Z","caller":"traceutil/trace.go:171","msg":"trace[284705714] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"555.524832ms","start":"2026-06-23T22:08:30.538431Z","end":"2026-06-23T22:08:31.093956Z","steps":["trace[284705714] 'process raft request' (duration: 551.277248ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:31.094437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:30.538402Z","time spent":"555.993214ms","remote":"127.0.0.1:47310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-23T22:08:31.098535Z","caller":"traceutil/trace.go:171","msg":"trace[1557256338] linearizableReadLoop","detail":"{readStateIndex:557; appliedIndex:546; }","duration":"272.472894ms","start":"2026-06-23T22:08:30.826022Z","end":"2026-06-23T22:08:31.098495Z","steps":["trace[1557256338] 'read index received' (duration: 224.593257ms)","trace[1557256338] 'applied index is now lower than readState.Index' (duration: 47.878707ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:08:31.098717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.691089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-23T22:08:31.098749Z","caller":"traceutil/trace.go:171","msg":"trace[240906761] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:537; }","duration":"272.781182ms","start":"2026-06-23T22:08:30.82596Z","end":"2026-06-23T22:08:31.098741Z","steps":["trace[240906761] 'agreement among raft nodes before linearized reading' (duration: 272.623328ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:31.098952Z","caller":"traceutil/trace.go:171","msg":"trace[596694855] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"544.665005ms","start":"2026-06-23T22:08:30.55428Z","end":"2026-06-23T22:08:31.098945Z","steps":["trace[596694855] 'process raft request' (duration: 543.980437ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:31.099046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:30.554249Z","time spent":"544.720647ms","remote":"127.0.0.1:47310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-23T22:08:31.099145Z","caller":"traceutil/trace.go:171","msg":"trace[1146826757] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"406.441952ms","start":"2026-06-23T22:08:30.692697Z","end":"2026-06-23T22:08:31.099139Z","steps":["trace[1146826757] 'process raft request' (duration: 405.711903ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:31.099173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:30.692667Z","time spent":"406.493563ms","remote":"127.0.0.1:47310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-23T22:08:37.556152Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745566210635869,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-23T22:08:37.701659Z","caller":"traceutil/trace.go:171","msg":"trace[665665704] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"645.874742ms","start":"2026-06-23T22:08:37.055756Z","end":"2026-06-23T22:08:37.701631Z","steps":["trace[665665704] 'read index received' (duration: 644.919827ms)","trace[665665704] 'applied index is now lower than readState.Index' (duration: 953.704µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:08:37.701767Z","caller":"traceutil/trace.go:171","msg":"trace[1151212953] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"757.264916ms","start":"2026-06-23T22:08:36.94448Z","end":"2026-06-23T22:08:37.701745Z","steps":["trace[1151212953] 'process raft request' (duration: 756.520018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:37.701898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:36.944443Z","time spent":"757.373039ms","remote":"127.0.0.1:47352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T22:08:37.701935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.430943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-23T22:08:37.70198Z","caller":"traceutil/trace.go:171","msg":"trace[431684388] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:622; }","duration":"542.507204ms","start":"2026-06-23T22:08:37.159459Z","end":"2026-06-23T22:08:37.701966Z","steps":["trace[431684388] 'agreement among raft nodes before linearized reading' (duration: 542.34646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:37.701992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.21056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hjx5s\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-23T22:08:37.702079Z","caller":"traceutil/trace.go:171","msg":"trace[1241376233] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hjx5s; range_end:; response_count:1; response_revision:622; }","duration":"646.342033ms","start":"2026-06-23T22:08:37.055715Z","end":"2026-06-23T22:08:37.702057Z","steps":["trace[1241376233] 'agreement among raft nodes before linearized reading' (duration: 646.062366ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:37.702126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:37.055698Z","time spent":"646.418725ms","remote":"127.0.0.1:47436","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-hjx5s\" "} {"level":"warn","ts":"2026-06-23T22:08:37.702127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.875742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-23T22:08:37.702165Z","caller":"traceutil/trace.go:171","msg":"trace[1916852571] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:622; }","duration":"393.945133ms","start":"2026-06-23T22:08:37.308208Z","end":"2026-06-23T22:08:37.702153Z","steps":["trace[1916852571] 'agreement among raft nodes before linearized reading' (duration: 393.84537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:37.702021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:37.159445Z","time spent":"542.565246ms","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-23T22:08:37.702203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:37.308189Z","time spent":"394.005835ms","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-23T22:08:38.348354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.869803ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T22:08:38.348484Z","caller":"traceutil/trace.go:171","msg":"trace[998309902] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"642.072952ms","start":"2026-06-23T22:08:37.706357Z","end":"2026-06-23T22:08:38.34843Z","steps":["trace[998309902] 'process raft request' (duration: 136.042905ms)","trace[998309902] 'compare' (duration: 505.77866ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:08:38.348582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:37.706336Z","time spent":"642.219775ms","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T22:08:38.349773Z","caller":"traceutil/trace.go:171","msg":"trace[94303840] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"642.953963ms","start":"2026-06-23T22:08:37.706781Z","end":"2026-06-23T22:08:38.349735Z","steps":["trace[94303840] 'process raft request' (duration: 642.730478ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:38.349942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:37.70676Z","time spent":"643.097756ms","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T22:08:38.350273Z","caller":"traceutil/trace.go:171","msg":"trace[689825217] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:648; }","duration":"523.13372ms","start":"2026-06-23T22:08:37.827065Z","end":"2026-06-23T22:08:38.350199Z","steps":["trace[689825217] 'read index received' (duration: 15.412921ms)","trace[689825217] 'applied index is now lower than readState.Index' (duration: 507.718599ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:08:38.350387Z","caller":"traceutil/trace.go:171","msg":"trace[1906262251] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"595.601194ms","start":"2026-06-23T22:08:37.754773Z","end":"2026-06-23T22:08:38.350374Z","steps":["trace[1906262251] 'process raft request' (duration: 595.291706ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:38.350469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:37.754753Z","time spent":"595.666325ms","remote":"127.0.0.1:47464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-23T22:08:38.350474Z","caller":"traceutil/trace.go:171","msg":"trace[2110898066] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"631.989825ms","start":"2026-06-23T22:08:37.718419Z","end":"2026-06-23T22:08:38.350408Z","steps":["trace[2110898066] 'process raft request' (duration: 631.256487ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:38.350582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.492928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-23T22:08:38.350629Z","caller":"traceutil/trace.go:171","msg":"trace[1369637906] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:626; }","duration":"523.605081ms","start":"2026-06-23T22:08:37.827009Z","end":"2026-06-23T22:08:38.350614Z","steps":["trace[1369637906] 'agreement among raft nodes before linearized reading' (duration: 523.351085ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:38.350626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:37.718401Z","time spent":"632.16313ms","remote":"127.0.0.1:47436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T22:08:38.350671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:37.826987Z","time spent":"523.674113ms","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-23T22:08:39.863438Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.093694991s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-23T22:08:39.870047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.335591363s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-23T22:08:39.870116Z","caller":"traceutil/trace.go:171","msg":"trace[306728786] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:627; }","duration":"1.335690456s","start":"2026-06-23T22:08:38.534408Z","end":"2026-06-23T22:08:39.870098Z","steps":["trace[306728786] 'range keys from in-memory index tree' (duration: 1.33546113s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:39.870161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:38.534377Z","time spent":"1.335770798s","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-23T22:08:39.870121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.325971903s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T22:08:39.870263Z","caller":"traceutil/trace.go:171","msg":"trace[1445243251] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"1.326123246s","start":"2026-06-23T22:08:38.544131Z","end":"2026-06-23T22:08:39.870254Z","steps":["trace[1445243251] 'range keys from in-memory index tree' (duration: 1.325949782s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:39.87029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:38.544125Z","time spent":"1.326158307s","remote":"127.0.0.1:47236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-23T22:08:39.87183Z","caller":"traceutil/trace.go:171","msg":"trace[1070419070] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"1.103536876s","start":"2026-06-23T22:08:38.768278Z","end":"2026-06-23T22:08:39.871815Z","steps":["trace[1070419070] 'process raft request' (duration: 1.095611519s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:39.871911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:38.76825Z","time spent":"1.103612327s","remote":"127.0.0.1:47352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036161,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T22:08:41.848749Z","caller":"traceutil/trace.go:171","msg":"trace[964114499] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:675; }","duration":"301.80558ms","start":"2026-06-23T22:08:41.546921Z","end":"2026-06-23T22:08:41.848727Z","steps":["trace[964114499] 'read index received' (duration: 293.487668ms)","trace[964114499] 'applied index is now lower than readState.Index' (duration: 8.316792ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:08:41.848957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.955554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T22:08:41.848992Z","caller":"traceutil/trace.go:171","msg":"trace[793943808] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:650; }","duration":"302.099607ms","start":"2026-06-23T22:08:41.546881Z","end":"2026-06-23T22:08:41.848981Z","steps":["trace[793943808] 'agreement among raft nodes before linearized reading' (duration: 301.947084ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:41.849025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:41.546863Z","time spent":"302.154328ms","remote":"127.0.0.1:47236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-23T22:08:41.849168Z","caller":"traceutil/trace.go:171","msg":"trace[269716343] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"464.701927ms","start":"2026-06-23T22:08:41.384436Z","end":"2026-06-23T22:08:41.849138Z","steps":["trace[269716343] 'process raft request' (duration: 456.027276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:41.849294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:41.384418Z","time spent":"464.81642ms","remote":"127.0.0.1:47634","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-06-23T22:08:44.464103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.427003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-06-23T22:08:44.464209Z","caller":"traceutil/trace.go:171","msg":"trace[138833610] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:706; }","duration":"167.571546ms","start":"2026-06-23T22:08:44.296612Z","end":"2026-06-23T22:08:44.464184Z","steps":["trace[138833610] 'range keys from in-memory index tree' (duration: 167.296619ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:44.855Z","caller":"traceutil/trace.go:171","msg":"trace[1841420913] linearizableReadLoop","detail":"{readStateIndex:738; appliedIndex:737; }","duration":"157.816026ms","start":"2026-06-23T22:08:44.697141Z","end":"2026-06-23T22:08:44.854957Z","steps":["trace[1841420913] 'read index received' (duration: 112.902073ms)","trace[1841420913] 'applied index is now lower than readState.Index' (duration: 44.911773ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:08:44.85508Z","caller":"traceutil/trace.go:171","msg":"trace[1526935133] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"310.620042ms","start":"2026-06-23T22:08:44.54443Z","end":"2026-06-23T22:08:44.85505Z","steps":["trace[1526935133] 'process raft request' (duration: 265.629417ms)","trace[1526935133] 'compare' (duration: 44.664587ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:08:44.855356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.155984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"warn","ts":"2026-06-23T22:08:44.855411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:44.544399Z","time spent":"310.814057ms","remote":"127.0.0.1:47310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24220,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T22:08:44.855476Z","caller":"traceutil/trace.go:171","msg":"trace[1705247943] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:711; }","duration":"158.292877ms","start":"2026-06-23T22:08:44.697129Z","end":"2026-06-23T22:08:44.855422Z","steps":["trace[1705247943] 'agreement among raft nodes before linearized reading' (duration: 158.00944ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:45.034791Z","caller":"traceutil/trace.go:171","msg":"trace[1061564005] linearizableReadLoop","detail":"{readStateIndex:739; appliedIndex:738; }","duration":"137.817295ms","start":"2026-06-23T22:08:44.896947Z","end":"2026-06-23T22:08:45.034764Z","steps":["trace[1061564005] 'read index received' (duration: 137.563399ms)","trace[1061564005] 'applied index is now lower than readState.Index' (duration: 252.686µs)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:08:45.035027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.069532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-06-23T22:08:45.035073Z","caller":"traceutil/trace.go:171","msg":"trace[648181358] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:712; }","duration":"138.171494ms","start":"2026-06-23T22:08:44.896887Z","end":"2026-06-23T22:08:45.035059Z","steps":["trace[648181358] 'agreement among raft nodes before linearized reading' (duration: 137.98079ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:45.035206Z","caller":"traceutil/trace.go:171","msg":"trace[1754786701] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"162.9306ms","start":"2026-06-23T22:08:44.87226Z","end":"2026-06-23T22:08:45.03519Z","steps":["trace[1754786701] 'process raft request' (duration: 162.342446ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:45.335328Z","caller":"traceutil/trace.go:171","msg":"trace[664717536] linearizableReadLoop","detail":"{readStateIndex:740; appliedIndex:739; }","duration":"220.616183ms","start":"2026-06-23T22:08:45.11468Z","end":"2026-06-23T22:08:45.335296Z","steps":["trace[664717536] 'read index received' (duration: 209.486802ms)","trace[664717536] 'applied index is now lower than readState.Index' (duration: 11.128181ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:08:45.335332Z","caller":"traceutil/trace.go:171","msg":"trace[1086514426] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"235.689716ms","start":"2026-06-23T22:08:45.099611Z","end":"2026-06-23T22:08:45.335301Z","steps":["trace[1086514426] 'process raft request' (duration: 224.543845ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:45.336181Z","caller":"traceutil/trace.go:171","msg":"trace[14913050] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"220.89447ms","start":"2026-06-23T22:08:45.115278Z","end":"2026-06-23T22:08:45.336173Z","steps":["trace[14913050] 'process raft request' (duration: 220.0602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:45.336198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.475793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hjx5s\" ","response":"range_response_count:1 size:18337"} {"level":"info","ts":"2026-06-23T22:08:45.336279Z","caller":"traceutil/trace.go:171","msg":"trace[2030616145] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hjx5s; range_end:; response_count:1; response_revision:713; }","duration":"221.616777ms","start":"2026-06-23T22:08:45.114641Z","end":"2026-06-23T22:08:45.336258Z","steps":["trace[2030616145] 'agreement among raft nodes before linearized reading' (duration: 220.727186ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:45.46876Z","caller":"traceutil/trace.go:171","msg":"trace[1819672984] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"141.54339ms","start":"2026-06-23T22:08:45.327193Z","end":"2026-06-23T22:08:45.468736Z","steps":["trace[1819672984] 'process raft request' (duration: 135.707893ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:45.655865Z","caller":"traceutil/trace.go:171","msg":"trace[681650941] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"312.035227ms","start":"2026-06-23T22:08:45.3438Z","end":"2026-06-23T22:08:45.655836Z","steps":["trace[681650941] 'process raft request' (duration: 240.772066ms)","trace[681650941] 'compare' (duration: 71.001185ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:08:45.656036Z","caller":"traceutil/trace.go:171","msg":"trace[783333185] linearizableReadLoop","detail":"{readStateIndex:744; appliedIndex:742; }","duration":"159.883119ms","start":"2026-06-23T22:08:45.496104Z","end":"2026-06-23T22:08:45.655987Z","steps":["trace[783333185] 'read index received' (duration: 88.493685ms)","trace[783333185] 'applied index is now lower than readState.Index' (duration: 71.383344ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:08:45.656266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:45.343776Z","time spent":"312.270843ms","remote":"127.0.0.1:47310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10353,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T22:08:45.656273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.43367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T22:08:45.656342Z","caller":"traceutil/trace.go:171","msg":"trace[13816383] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:718; }","duration":"110.538932ms","start":"2026-06-23T22:08:45.545785Z","end":"2026-06-23T22:08:45.656324Z","steps":["trace[13816383] 'agreement among raft nodes before linearized reading' (duration: 110.43895ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:45.656361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.242187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-06-23T22:08:45.655973Z","caller":"traceutil/trace.go:171","msg":"trace[642299765] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"305.395341ms","start":"2026-06-23T22:08:45.350544Z","end":"2026-06-23T22:08:45.655939Z","steps":["trace[642299765] 'process raft request' (duration: 305.175506ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:08:45.656403Z","caller":"traceutil/trace.go:171","msg":"trace[1796631355] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:718; }","duration":"160.34318ms","start":"2026-06-23T22:08:45.496046Z","end":"2026-06-23T22:08:45.656389Z","steps":["trace[1796631355] 'agreement among raft nodes before linearized reading' (duration: 160.122015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:45.656804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:45.350512Z","time spent":"306.20166ms","remote":"127.0.0.1:47436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18501,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T22:08:55.03105Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745566210636195,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-23T22:08:55.532092Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085745566210636195,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-23T22:08:55.545522Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.01768316s","expected-duration":"1s"} {"level":"info","ts":"2026-06-23T22:08:55.545834Z","caller":"traceutil/trace.go:171","msg":"trace[1598736125] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"1.018077469s","start":"2026-06-23T22:08:54.527733Z","end":"2026-06-23T22:08:55.54581Z","steps":["trace[1598736125] 'process raft request' (duration: 1.017947206s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:55.545975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:54.527706Z","time spent":"1.018203501s","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T22:08:55.7621Z","caller":"traceutil/trace.go:171","msg":"trace[1320193334] linearizableReadLoop","detail":"{readStateIndex:828; appliedIndex:826; }","duration":"1.23107164s","start":"2026-06-23T22:08:54.531004Z","end":"2026-06-23T22:08:55.762075Z","steps":["trace[1320193334] 'read index received' (duration: 1.014725506s)","trace[1320193334] 'applied index is now lower than readState.Index' (duration: 216.345364ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:08:55.762388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.217216561s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T22:08:55.762467Z","caller":"traceutil/trace.go:171","msg":"trace[1801249849] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:798; }","duration":"1.217335753s","start":"2026-06-23T22:08:54.545109Z","end":"2026-06-23T22:08:55.762445Z","steps":["trace[1801249849] 'agreement among raft nodes before linearized reading' (duration: 1.217228321s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:55.762488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.227715207s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-23T22:08:55.762532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:54.545089Z","time spent":"1.217429465s","remote":"127.0.0.1:47236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-23T22:08:55.762579Z","caller":"traceutil/trace.go:171","msg":"trace[950521978] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:798; }","duration":"1.227850461s","start":"2026-06-23T22:08:54.534708Z","end":"2026-06-23T22:08:55.762558Z","steps":["trace[950521978] 'agreement among raft nodes before linearized reading' (duration: 1.227598625s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:55.762633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:54.534696Z","time spent":"1.227925312s","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-23T22:08:55.763295Z","caller":"traceutil/trace.go:171","msg":"trace[662595095] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"585.937891ms","start":"2026-06-23T22:08:55.17666Z","end":"2026-06-23T22:08:55.762598Z","steps":["trace[662595095] 'process raft request' (duration: 585.283318ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:55.763484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:55.176639Z","time spent":"586.727469ms","remote":"127.0.0.1:47512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T22:08:55.762392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.231377927s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-23T22:08:55.763677Z","caller":"traceutil/trace.go:171","msg":"trace[229143704] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:798; }","duration":"1.232670364s","start":"2026-06-23T22:08:54.530987Z","end":"2026-06-23T22:08:55.763657Z","steps":["trace[229143704] 'agreement among raft nodes before linearized reading' (duration: 1.231235823s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:08:55.763736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:08:54.530977Z","time spent":"1.232741795s","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-23T22:08:55.762389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.448751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-23T22:08:55.763832Z","caller":"traceutil/trace.go:171","msg":"trace[575827857] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:798; }","duration":"143.929083ms","start":"2026-06-23T22:08:55.619882Z","end":"2026-06-23T22:08:55.763811Z","steps":["trace[575827857] 'agreement among raft nodes before linearized reading' (duration: 142.435331ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:09:00.210729Z","caller":"traceutil/trace.go:171","msg":"trace[312703092] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"155.377439ms","start":"2026-06-23T22:09:00.055324Z","end":"2026-06-23T22:09:00.210702Z","steps":["trace[312703092] 'process raft request' (duration: 153.465989ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:09:18.507749Z","caller":"traceutil/trace.go:171","msg":"trace[499351901] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"141.843276ms","start":"2026-06-23T22:09:18.365877Z","end":"2026-06-23T22:09:18.50772Z","steps":["trace[499351901] 'process raft request' (duration: 141.664413ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:09:22.195341Z","caller":"traceutil/trace.go:171","msg":"trace[773451994] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"268.801621ms","start":"2026-06-23T22:09:21.926517Z","end":"2026-06-23T22:09:22.195318Z","steps":["trace[773451994] 'process raft request' (duration: 222.259315ms)","trace[773451994] 'compare' (duration: 46.344222ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:09:22.299883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.617661ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-23T22:09:22.300052Z","caller":"traceutil/trace.go:171","msg":"trace[834894204] linearizableReadLoop","detail":"{readStateIndex:1052; appliedIndex:1050; }","duration":"121.104506ms","start":"2026-06-23T22:09:22.178931Z","end":"2026-06-23T22:09:22.300036Z","steps":["trace[834894204] 'read index received' (duration: 28.821µs)","trace[834894204] 'applied index is now lower than readState.Index' (duration: 121.074475ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:09:22.300241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.298459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-23T22:09:22.300296Z","caller":"traceutil/trace.go:171","msg":"trace[780952248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1014; }","duration":"121.39088ms","start":"2026-06-23T22:09:22.178896Z","end":"2026-06-23T22:09:22.300286Z","steps":["trace[780952248] 'agreement among raft nodes before linearized reading' (duration: 121.222687ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:09:27.094144Z","caller":"traceutil/trace.go:171","msg":"trace[1001354414] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"129.198004ms","start":"2026-06-23T22:09:26.964927Z","end":"2026-06-23T22:09:27.094125Z","steps":["trace[1001354414] 'process raft request' (duration: 129.092272ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:09:29.202834Z","caller":"traceutil/trace.go:171","msg":"trace[34487632] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"187.175167ms","start":"2026-06-23T22:09:29.015634Z","end":"2026-06-23T22:09:29.202809Z","steps":["trace[34487632] 'process raft request' (duration: 187.032835ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:09:29.295807Z","caller":"traceutil/trace.go:171","msg":"trace[169338402] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"196.943698ms","start":"2026-06-23T22:09:29.098839Z","end":"2026-06-23T22:09:29.295783Z","steps":["trace[169338402] 'process raft request' (duration: 159.282137ms)","trace[169338402] 'compare' (duration: 37.526739ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:09:31.593509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.41191ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T22:09:31.593842Z","caller":"traceutil/trace.go:171","msg":"trace[143429071] linearizableReadLoop","detail":"{readStateIndex:1089; appliedIndex:1088; }","duration":"146.718589ms","start":"2026-06-23T22:09:31.447101Z","end":"2026-06-23T22:09:31.593819Z","steps":["trace[143429071] 'read index received' (duration: 17.78237ms)","trace[143429071] 'applied index is now lower than readState.Index' (duration: 128.934059ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:09:31.593883Z","caller":"traceutil/trace.go:171","msg":"trace[546982467] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"219.267889ms","start":"2026-06-23T22:09:31.374575Z","end":"2026-06-23T22:09:31.593843Z","steps":["trace[546982467] 'process raft request' (duration: 90.432452ms)","trace[546982467] 'compare' (duration: 128.263988ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:09:31.594001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.897801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-23T22:09:31.594105Z","caller":"traceutil/trace.go:171","msg":"trace[1504800483] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1049; }","duration":"147.040624ms","start":"2026-06-23T22:09:31.447048Z","end":"2026-06-23T22:09:31.594088Z","steps":["trace[1504800483] 'agreement among raft nodes before linearized reading' (duration: 146.898592ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:09:32.663543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.308192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T22:09:32.663623Z","caller":"traceutil/trace.go:171","msg":"trace[978278715] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1053; }","duration":"116.454864ms","start":"2026-06-23T22:09:32.547148Z","end":"2026-06-23T22:09:32.663603Z","steps":["trace[978278715] 'range keys from in-memory index tree' (duration: 116.24262ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:09:56.666501Z","caller":"traceutil/trace.go:171","msg":"trace[2117385467] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"126.311258ms","start":"2026-06-23T22:09:56.540174Z","end":"2026-06-23T22:09:56.666486Z","steps":["trace[2117385467] 'process raft request' (duration: 125.509457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:09:56.666576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.677719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T22:09:56.666484Z","caller":"traceutil/trace.go:171","msg":"trace[694879153] linearizableReadLoop","detail":"{readStateIndex:1176; appliedIndex:1175; }","duration":"120.573548ms","start":"2026-06-23T22:09:56.545877Z","end":"2026-06-23T22:09:56.666451Z","steps":["trace[694879153] 'read index received' (duration: 119.652955ms)","trace[694879153] 'applied index is now lower than readState.Index' (duration: 919.603µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:09:56.666622Z","caller":"traceutil/trace.go:171","msg":"trace[598169474] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1131; }","duration":"120.75492ms","start":"2026-06-23T22:09:56.545858Z","end":"2026-06-23T22:09:56.666613Z","steps":["trace[598169474] 'agreement among raft nodes before linearized reading' (duration: 120.672079ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:10:09.714024Z","caller":"traceutil/trace.go:171","msg":"trace[982277124] linearizableReadLoop","detail":"{readStateIndex:1222; appliedIndex:1221; }","duration":"115.350818ms","start":"2026-06-23T22:10:09.598654Z","end":"2026-06-23T22:10:09.714005Z","steps":["trace[982277124] 'read index received' (duration: 115.163005ms)","trace[982277124] 'applied index is now lower than readState.Index' (duration: 186.913µs)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:10:09.714174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.502989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T22:10:09.714258Z","caller":"traceutil/trace.go:171","msg":"trace[568464909] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1174; }","duration":"115.631522ms","start":"2026-06-23T22:10:09.598612Z","end":"2026-06-23T22:10:09.714243Z","steps":["trace[568464909] 'agreement among raft nodes before linearized reading' (duration: 115.49327ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:10:09.714283Z","caller":"traceutil/trace.go:171","msg":"trace[1345893981] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"138.16613ms","start":"2026-06-23T22:10:09.576078Z","end":"2026-06-23T22:10:09.714244Z","steps":["trace[1345893981] 'process raft request' (duration: 137.795065ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:10:10.380784Z","caller":"traceutil/trace.go:171","msg":"trace[544088404] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"165.064816ms","start":"2026-06-23T22:10:10.215695Z","end":"2026-06-23T22:10:10.380759Z","steps":["trace[544088404] 'process raft request' (duration: 72.431255ms)","trace[544088404] 'compare' (duration: 92.52849ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:10:24.973831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.890439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-23T22:10:24.973899Z","caller":"traceutil/trace.go:171","msg":"trace[8813979] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1222; }","duration":"130.00268ms","start":"2026-06-23T22:10:24.843881Z","end":"2026-06-23T22:10:24.973884Z","steps":["trace[8813979] 'range keys from in-memory index tree' (duration: 129.698926ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:10:24.9741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.415218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-23T22:10:24.974182Z","caller":"traceutil/trace.go:171","msg":"trace[410598571] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1222; }","duration":"346.532449ms","start":"2026-06-23T22:10:24.627632Z","end":"2026-06-23T22:10:24.974164Z","steps":["trace[410598571] 'range keys from in-memory index tree' (duration: 345.878261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:10:24.974223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:10:24.627616Z","time spent":"346.596839ms","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-23T22:10:25.143869Z","caller":"traceutil/trace.go:171","msg":"trace[730791154] linearizableReadLoop","detail":"{readStateIndex:1275; appliedIndex:1274; }","duration":"112.912222ms","start":"2026-06-23T22:10:25.030923Z","end":"2026-06-23T22:10:25.143835Z","steps":["trace[730791154] 'read index received' (duration: 108.145842ms)","trace[730791154] 'applied index is now lower than readState.Index' (duration: 4.7649ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:10:25.143917Z","caller":"traceutil/trace.go:171","msg":"trace[1313039838] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"166.252135ms","start":"2026-06-23T22:10:24.977633Z","end":"2026-06-23T22:10:25.143885Z","steps":["trace[1313039838] 'process raft request' (duration: 161.476276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:10:25.144238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.237596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:1 size:12751"} {"level":"info","ts":"2026-06-23T22:10:25.144305Z","caller":"traceutil/trace.go:171","msg":"trace[101562510] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:1; response_revision:1224; }","duration":"113.366377ms","start":"2026-06-23T22:10:25.030918Z","end":"2026-06-23T22:10:25.144284Z","steps":["trace[101562510] 'agreement among raft nodes before linearized reading' (duration: 113.102774ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:10:42.264009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.523243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T22:10:42.264093Z","caller":"traceutil/trace.go:171","msg":"trace[1587971792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1317; }","duration":"386.644314ms","start":"2026-06-23T22:10:41.877422Z","end":"2026-06-23T22:10:42.264066Z","steps":["trace[1587971792] 'range keys from in-memory index tree' (duration: 386.447091ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:10:42.264131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:10:41.877402Z","time spent":"386.721915ms","remote":"127.0.0.1:47236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-23T22:10:42.290235Z","caller":"traceutil/trace.go:171","msg":"trace[1823943051] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"337.248461ms","start":"2026-06-23T22:10:41.95297Z","end":"2026-06-23T22:10:42.290219Z","steps":["trace[1823943051] 'process raft request' (duration: 337.11668ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:10:42.29035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:10:41.952951Z","time spent":"337.332452ms","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T22:10:42.554386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.289392ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T22:10:42.554623Z","caller":"traceutil/trace.go:171","msg":"trace[867790733] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"599.391108ms","start":"2026-06-23T22:10:41.955197Z","end":"2026-06-23T22:10:42.554588Z","steps":["trace[867790733] 'process raft request' (duration: 461.767652ms)","trace[867790733] 'compare' (duration: 137.060399ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:10:42.554767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:10:41.95517Z","time spent":"599.51843ms","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T22:10:42.785856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.294445ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-23T22:10:42.786062Z","caller":"traceutil/trace.go:171","msg":"trace[837429068] linearizableReadLoop","detail":"{readStateIndex:1374; appliedIndex:1372; }","duration":"769.660695ms","start":"2026-06-23T22:10:42.016314Z","end":"2026-06-23T22:10:42.785975Z","steps":["trace[837429068] 'read index received' (duration: 273.829504ms)","trace[837429068] 'applied index is now lower than readState.Index' (duration: 495.828791ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:10:42.786187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"769.840947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T22:10:42.786341Z","caller":"traceutil/trace.go:171","msg":"trace[1794440313] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1319; }","duration":"769.979069ms","start":"2026-06-23T22:10:42.016278Z","end":"2026-06-23T22:10:42.786257Z","steps":["trace[1794440313] 'agreement among raft nodes before linearized reading' (duration: 769.802866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:10:42.786423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:10:42.016263Z","time spent":"770.1435ms","remote":"127.0.0.1:47566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-23T22:10:42.786511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.245724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T22:10:42.786589Z","caller":"traceutil/trace.go:171","msg":"trace[794898942] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1319; }","duration":"242.368015ms","start":"2026-06-23T22:10:42.544181Z","end":"2026-06-23T22:10:42.786549Z","steps":["trace[794898942] 'agreement among raft nodes before linearized reading' (duration: 242.228253ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:10:42.786613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.621687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-23T22:10:42.786865Z","caller":"traceutil/trace.go:171","msg":"trace[1234173012] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1319; }","duration":"161.970701ms","start":"2026-06-23T22:10:42.624873Z","end":"2026-06-23T22:10:42.786844Z","steps":["trace[1234173012] 'agreement among raft nodes before linearized reading' (duration: 161.483286ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:10:42.78718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.502372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-23T22:10:42.787284Z","caller":"traceutil/trace.go:171","msg":"trace[1044904740] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1319; }","duration":"429.672554ms","start":"2026-06-23T22:10:42.357585Z","end":"2026-06-23T22:10:42.787258Z","steps":["trace[1044904740] 'agreement among raft nodes before linearized reading' (duration: 428.734833ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:10:42.78735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T22:10:42.357567Z","time spent":"429.768595ms","remote":"127.0.0.1:47532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-23T22:10:43.437306Z","caller":"traceutil/trace.go:171","msg":"trace[1016207010] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"186.484652ms","start":"2026-06-23T22:10:43.250794Z","end":"2026-06-23T22:10:43.437279Z","steps":["trace[1016207010] 'process raft request' (duration: 186.234499ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:10:44.749594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.442081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-23T22:10:44.749777Z","caller":"traceutil/trace.go:171","msg":"trace[129502036] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1325; }","duration":"123.658774ms","start":"2026-06-23T22:10:44.626102Z","end":"2026-06-23T22:10:44.749761Z","steps":["trace[129502036] 'count revisions from in-memory index tree' (duration: 123.392651ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:10:44.749854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.820955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 ","response":"range_response_count:6 size:2185"} {"level":"info","ts":"2026-06-23T22:10:44.749981Z","caller":"traceutil/trace.go:171","msg":"trace[2033316854] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:6; response_revision:1325; }","duration":"232.002158ms","start":"2026-06-23T22:10:44.517942Z","end":"2026-06-23T22:10:44.749944Z","steps":["trace[2033316854] 'range keys from in-memory index tree' (duration: 231.594724ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:10:44.951754Z","caller":"traceutil/trace.go:171","msg":"trace[884040235] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"106.448623ms","start":"2026-06-23T22:10:44.845278Z","end":"2026-06-23T22:10:44.951727Z","steps":["trace[884040235] 'process raft request' (duration: 106.262901ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:10:45.650413Z","caller":"traceutil/trace.go:171","msg":"trace[1833546611] linearizableReadLoop","detail":"{readStateIndex:1388; appliedIndex:1387; }","duration":"107.327759ms","start":"2026-06-23T22:10:45.543063Z","end":"2026-06-23T22:10:45.650391Z","steps":["trace[1833546611] 'read index received' (duration: 107.121717ms)","trace[1833546611] 'applied index is now lower than readState.Index' (duration: 205.342µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:10:45.650525Z","caller":"traceutil/trace.go:171","msg":"trace[100095457] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"133.601965ms","start":"2026-06-23T22:10:45.51689Z","end":"2026-06-23T22:10:45.650492Z","steps":["trace[100095457] 'process raft request' (duration: 133.375343ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:10:45.650615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.537711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2766"} {"level":"info","ts":"2026-06-23T22:10:45.650646Z","caller":"traceutil/trace.go:171","msg":"trace[268813198] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1332; }","duration":"107.625003ms","start":"2026-06-23T22:10:45.543012Z","end":"2026-06-23T22:10:45.650637Z","steps":["trace[268813198] 'agreement among raft nodes before linearized reading' (duration: 107.500231ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:10:45.650705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.91796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-node-lease/\" range_end:\"/registry/secrets/kube-node-lease0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T22:10:45.650739Z","caller":"traceutil/trace.go:171","msg":"trace[1582189909] range","detail":"{range_begin:/registry/secrets/kube-node-lease/; range_end:/registry/secrets/kube-node-lease0; response_count:0; response_revision:1332; }","duration":"103.97168ms","start":"2026-06-23T22:10:45.546757Z","end":"2026-06-23T22:10:45.650729Z","steps":["trace[1582189909] 'agreement among raft nodes before linearized reading' (duration: 103.904599ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:10:45.650732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.187828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T22:10:45.650818Z","caller":"traceutil/trace.go:171","msg":"trace[1711160689] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1332; }","duration":"107.310649ms","start":"2026-06-23T22:10:45.543485Z","end":"2026-06-23T22:10:45.650795Z","steps":["trace[1711160689] 'agreement among raft nodes before linearized reading' (duration: 107.158387ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:10:47.857366Z","caller":"traceutil/trace.go:171","msg":"trace[936724826] linearizableReadLoop","detail":"{readStateIndex:1398; appliedIndex:1397; }","duration":"160.75589ms","start":"2026-06-23T22:10:47.696587Z","end":"2026-06-23T22:10:47.857343Z","steps":["trace[936724826] 'read index received' (duration: 160.598638ms)","trace[936724826] 'applied index is now lower than readState.Index' (duration: 156.072µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T22:10:47.857488Z","caller":"traceutil/trace.go:171","msg":"trace[712205229] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"196.892318ms","start":"2026-06-23T22:10:47.660584Z","end":"2026-06-23T22:10:47.857477Z","steps":["trace[712205229] 'process raft request' (duration: 196.620475ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:10:47.8577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.814185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cilium-operator\" ","response":"range_response_count:1 size:2379"} {"level":"info","ts":"2026-06-23T22:10:47.857771Z","caller":"traceutil/trace.go:171","msg":"trace[670181161] range","detail":"{range_begin:/registry/clusterroles/cilium-operator; range_end:; response_count:1; response_revision:1341; }","duration":"131.892747ms","start":"2026-06-23T22:10:47.725861Z","end":"2026-06-23T22:10:47.857754Z","steps":["trace[670181161] 'agreement among raft nodes before linearized reading' (duration: 131.687684ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:10:47.857968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.144983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cilium\" ","response":"range_response_count:1 size:1654"} {"level":"info","ts":"2026-06-23T22:10:47.858005Z","caller":"traceutil/trace.go:171","msg":"trace[229500200] range","detail":"{range_begin:/registry/clusterroles/cilium; range_end:; response_count:1; response_revision:1341; }","duration":"122.212084ms","start":"2026-06-23T22:10:47.735784Z","end":"2026-06-23T22:10:47.857996Z","steps":["trace[229500200] 'agreement among raft nodes before linearized reading' (duration: 122.152094ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T22:10:47.85841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.801643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 ","response":"range_response_count:6 size:2185"} {"level":"info","ts":"2026-06-23T22:10:47.858459Z","caller":"traceutil/trace.go:171","msg":"trace[665033669] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:6; response_revision:1341; }","duration":"161.864274ms","start":"2026-06-23T22:10:47.696582Z","end":"2026-06-23T22:10:47.858446Z","steps":["trace[665033669] 'agreement among raft nodes before linearized reading' (duration: 161.251567ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T22:11:07.346778Z","caller":"traceutil/trace.go:171","msg":"trace[2077399699] transaction","detail":"{read_only:false; response_revision:1405; number_of_response:1; }","duration":"169.393397ms","start":"2026-06-23T22:11:07.177353Z","end":"2026-06-23T22:11:07.346746Z","steps":["trace[2077399699] 'process raft request' (duration: 94.037657ms)","trace[2077399699] 'compare' (duration: 75.215269ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T22:11:10.164793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.951068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:86 size:63962"} {"level":"info","ts":"2026-06-23T22:11:10.164879Z","caller":"traceutil/trace.go:171","msg":"trace[2064649399] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:86; response_revision:1415; }","duration":"103.089889ms","start":"2026-06-23T22:11:10.06177Z","end":"2026-06-23T22:11:10.16486Z","steps":["trace[2064649399] 'range keys from in-memory index tree' (duration: 102.340591ms)"],"step_count":1}