{"level":"warn","ts":"2026-06-24T00:54:53.439949Z","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-24T00:54:53.440036Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.49: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.49:2380","--initial-cluster=instance=https://199.204.45.49:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.49:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.49: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-24T00:54:53.440099Z","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-24T00:54:53.440106Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.49:2380"]} {"level":"info","ts":"2026-06-24T00:54:53.440123Z","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-24T00:54:53.441095Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"]} {"level":"info","ts":"2026-06-24T00:54:53.441171Z","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.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.49: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-24T00:54:53.443193Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.825212ms"} {"level":"info","ts":"2026-06-24T00:54:53.44895Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d0ba3c4de8c6ef7a","cluster-id":"e76701b877f442ac"} {"level":"info","ts":"2026-06-24T00:54:53.449021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=()"} {"level":"info","ts":"2026-06-24T00:54:53.449038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 0"} {"level":"info","ts":"2026-06-24T00:54:53.449053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d0ba3c4de8c6ef7a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-24T00:54:53.449062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 1"} {"level":"info","ts":"2026-06-24T00:54:53.449119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"} {"level":"warn","ts":"2026-06-24T00:54:53.45856Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-24T00:54:53.460052Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-24T00:54:53.461235Z","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-24T00:54:53.463212Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d0ba3c4de8c6ef7a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-24T00:54:53.465258Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d0ba3c4de8c6ef7a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-24T00:54:53.465397Z","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-24T00:54:53.46543Z","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-24T00:54:53.465479Z","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-24T00:54:53.466835Z","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-24T00:54:53.46703Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d0ba3c4de8c6ef7a","initial-advertise-peer-urls":["https://199.204.45.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-24T00:54:53.467064Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-24T00:54:53.467121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"} {"level":"info","ts":"2026-06-24T00:54:53.467176Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.49:2380"} {"level":"info","ts":"2026-06-24T00:54:53.467203Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.49:2380"} {"level":"info","ts":"2026-06-24T00:54:53.467294Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","added-peer-id":"d0ba3c4de8c6ef7a","added-peer-peer-urls":["https://199.204.45.49:2380"]} {"level":"info","ts":"2026-06-24T00:54:53.6496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a is starting a new election at term 1"} {"level":"info","ts":"2026-06-24T00:54:53.649645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became pre-candidate at term 1"} {"level":"info","ts":"2026-06-24T00:54:53.649671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgPreVoteResp from d0ba3c4de8c6ef7a at term 1"} {"level":"info","ts":"2026-06-24T00:54:53.649684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became candidate at term 2"} {"level":"info","ts":"2026-06-24T00:54:53.649692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgVoteResp from d0ba3c4de8c6ef7a at term 2"} {"level":"info","ts":"2026-06-24T00:54:53.649704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became leader at term 2"} {"level":"info","ts":"2026-06-24T00:54:53.649718Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d0ba3c4de8c6ef7a elected leader d0ba3c4de8c6ef7a at term 2"} {"level":"info","ts":"2026-06-24T00:54:53.650527Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T00:54:53.651812Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d0ba3c4de8c6ef7a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.49:2379]}","request-path":"/0/members/d0ba3c4de8c6ef7a/attributes","cluster-id":"e76701b877f442ac","publish-timeout":"7s"} {"level":"info","ts":"2026-06-24T00:54:53.651997Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T00:54:53.652039Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T00:54:53.652168Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-24T00:54:53.652258Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-24T00:54:53.652227Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T00:54:53.652417Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T00:54:53.652451Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T00:54:53.655029Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-24T00:54:53.655454Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.49:2379"} {"level":"info","ts":"2026-06-24T00:54:56.262351Z","caller":"traceutil/trace.go:171","msg":"trace[1148016503] linearizableReadLoop","detail":"{readStateIndex:79; appliedIndex:78; }","duration":"153.59589ms","start":"2026-06-24T00:54:56.10873Z","end":"2026-06-24T00:54:56.262326Z","steps":["trace[1148016503] 'read index received' (duration: 59.717133ms)","trace[1148016503] 'applied index is now lower than readState.Index' (duration: 93.870187ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:54:56.262462Z","caller":"traceutil/trace.go:171","msg":"trace[22514963] transaction","detail":"{read_only:false; response_revision:75; number_of_response:1; }","duration":"158.401023ms","start":"2026-06-24T00:54:56.104014Z","end":"2026-06-24T00:54:56.262415Z","steps":["trace[22514963] 'process raft request' (duration: 64.491096ms)","trace[22514963] 'compare' (duration: 93.697162ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:54:56.262525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.747063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T00:54:56.262595Z","caller":"traceutil/trace.go:171","msg":"trace[1263142338] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:75; }","duration":"153.879557ms","start":"2026-06-24T00:54:56.108699Z","end":"2026-06-24T00:54:56.262578Z","steps":["trace[1263142338] 'agreement among raft nodes before linearized reading' (duration: 153.727283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:54:56.827409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.955452ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-24T00:54:56.827517Z","caller":"traceutil/trace.go:171","msg":"trace[1219223422] transaction","detail":"{read_only:false; response_revision:118; number_of_response:1; }","duration":"137.080091ms","start":"2026-06-24T00:54:56.690416Z","end":"2026-06-24T00:54:56.827496Z","steps":["trace[1219223422] 'process raft request' (duration: 21.551186ms)","trace[1219223422] 'compare' (duration: 114.839239ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:54:58.095657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.152517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-06-24T00:54:58.09575Z","caller":"traceutil/trace.go:171","msg":"trace[651291704] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:208; }","duration":"121.29175ms","start":"2026-06-24T00:54:57.974438Z","end":"2026-06-24T00:54:58.09573Z","steps":["trace[651291704] 'range keys from in-memory index tree' (duration: 121.039885ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:00.308613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.269176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"warn","ts":"2026-06-24T00:55:00.308652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.771491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-06-24T00:55:00.308714Z","caller":"traceutil/trace.go:171","msg":"trace[2081815155] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:271; }","duration":"117.42091ms","start":"2026-06-24T00:55:00.19127Z","end":"2026-06-24T00:55:00.308691Z","steps":["trace[2081815155] 'range keys from in-memory index tree' (duration: 117.108972ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:00.308751Z","caller":"traceutil/trace.go:171","msg":"trace[400512802] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:271; }","duration":"138.901374ms","start":"2026-06-24T00:55:00.169825Z","end":"2026-06-24T00:55:00.308726Z","steps":["trace[400512802] 'range keys from in-memory index tree' (duration: 138.679079ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:00.380659Z","caller":"traceutil/trace.go:171","msg":"trace[961392924] transaction","detail":"{read_only:false; number_of_response:0; response_revision:271; }","duration":"188.818567ms","start":"2026-06-24T00:55:00.191816Z","end":"2026-06-24T00:55:00.380635Z","steps":["trace[961392924] 'process raft request' (duration: 188.702715ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:00.395494Z","caller":"traceutil/trace.go:171","msg":"trace[629102462] transaction","detail":"{read_only:false; number_of_response:0; response_revision:271; }","duration":"203.429791ms","start":"2026-06-24T00:55:00.192049Z","end":"2026-06-24T00:55:00.395479Z","steps":["trace[629102462] 'process raft request' (duration: 203.234006ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:00.395523Z","caller":"traceutil/trace.go:171","msg":"trace[1309783618] transaction","detail":"{read_only:false; number_of_response:0; response_revision:271; }","duration":"202.10703ms","start":"2026-06-24T00:55:00.193396Z","end":"2026-06-24T00:55:00.395503Z","steps":["trace[1309783618] 'process raft request' (duration: 202.019158ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:00.3956Z","caller":"traceutil/trace.go:171","msg":"trace[1551316247] transaction","detail":"{read_only:false; number_of_response:0; response_revision:271; }","duration":"202.103439ms","start":"2026-06-24T00:55:00.193474Z","end":"2026-06-24T00:55:00.395578Z","steps":["trace[1551316247] 'process raft request' (duration: 201.981436ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:00.395665Z","caller":"traceutil/trace.go:171","msg":"trace[1778145297] transaction","detail":"{read_only:false; number_of_response:0; response_revision:271; }","duration":"201.014424ms","start":"2026-06-24T00:55:00.194638Z","end":"2026-06-24T00:55:00.395653Z","steps":["trace[1778145297] 'process raft request' (duration: 200.85029ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:03.197601Z","caller":"traceutil/trace.go:171","msg":"trace[1629464408] linearizableReadLoop","detail":"{readStateIndex:318; appliedIndex:316; }","duration":"128.176243ms","start":"2026-06-24T00:55:03.069324Z","end":"2026-06-24T00:55:03.1975Z","steps":["trace[1629464408] 'read index received' (duration: 54.162103ms)","trace[1629464408] 'applied index is now lower than readState.Index' (duration: 74.01326ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:03.197612Z","caller":"traceutil/trace.go:171","msg":"trace[1004574619] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"137.262605ms","start":"2026-06-24T00:55:03.060316Z","end":"2026-06-24T00:55:03.197579Z","steps":["trace[1004574619] 'process raft request' (duration: 137.062911ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:03.197871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.475749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-06-24T00:55:03.197932Z","caller":"traceutil/trace.go:171","msg":"trace[1342297080] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:304; }","duration":"128.636393ms","start":"2026-06-24T00:55:03.069284Z","end":"2026-06-24T00:55:03.197921Z","steps":["trace[1342297080] 'agreement among raft nodes before linearized reading' (duration: 128.463989ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:03.32201Z","caller":"traceutil/trace.go:171","msg":"trace[1069543323] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"114.629744ms","start":"2026-06-24T00:55:03.207347Z","end":"2026-06-24T00:55:03.321977Z","steps":["trace[1069543323] 'process raft request' (duration: 99.870437ms)","trace[1069543323] 'compare' (duration: 14.624604ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:03.458455Z","caller":"traceutil/trace.go:171","msg":"trace[1531764438] linearizableReadLoop","detail":"{readStateIndex:320; appliedIndex:318; }","duration":"238.409033ms","start":"2026-06-24T00:55:03.220026Z","end":"2026-06-24T00:55:03.458435Z","steps":["trace[1531764438] 'read index received' (duration: 87.155738ms)","trace[1531764438] 'applied index is now lower than readState.Index' (duration: 151.252575ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:55:03.458591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.551486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-24T00:55:03.458619Z","caller":"traceutil/trace.go:171","msg":"trace[1747324367] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:306; }","duration":"238.612988ms","start":"2026-06-24T00:55:03.219998Z","end":"2026-06-24T00:55:03.458611Z","steps":["trace[1747324367] 'agreement among raft nodes before linearized reading' (duration: 238.546607ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:03.458785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.526801ms","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-24T00:55:03.458808Z","caller":"traceutil/trace.go:171","msg":"trace[2009885621] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:306; }","duration":"188.589473ms","start":"2026-06-24T00:55:03.270212Z","end":"2026-06-24T00:55:03.458802Z","steps":["trace[2009885621] 'agreement among raft nodes before linearized reading' (duration: 188.542092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:03.458956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.692529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4368"} {"level":"info","ts":"2026-06-24T00:55:03.458997Z","caller":"traceutil/trace.go:171","msg":"trace[1885191970] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:306; }","duration":"135.73279ms","start":"2026-06-24T00:55:03.323256Z","end":"2026-06-24T00:55:03.458989Z","steps":["trace[1885191970] 'agreement among raft nodes before linearized reading' (duration: 135.672989ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:03.458996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.565127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6961"} {"level":"info","ts":"2026-06-24T00:55:03.459055Z","caller":"traceutil/trace.go:171","msg":"trace[960537222] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:306; }","duration":"135.625978ms","start":"2026-06-24T00:55:03.323415Z","end":"2026-06-24T00:55:03.459041Z","steps":["trace[960537222] 'agreement among raft nodes before linearized reading' (duration: 135.502925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:03.459172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.988997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-06-24T00:55:03.459314Z","caller":"traceutil/trace.go:171","msg":"trace[1149641251] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:306; }","duration":"139.177451ms","start":"2026-06-24T00:55:03.320113Z","end":"2026-06-24T00:55:03.459291Z","steps":["trace[1149641251] 'agreement among raft nodes before linearized reading' (duration: 138.825083ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:03.458529Z","caller":"traceutil/trace.go:171","msg":"trace[307963475] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"250.898797ms","start":"2026-06-24T00:55:03.207602Z","end":"2026-06-24T00:55:03.458501Z","steps":["trace[307963475] 'process raft request' (duration: 243.060102ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:03.45932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.177601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4659"} {"level":"info","ts":"2026-06-24T00:55:03.460096Z","caller":"traceutil/trace.go:171","msg":"trace[1452351334] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:306; }","duration":"136.862487ms","start":"2026-06-24T00:55:03.323061Z","end":"2026-06-24T00:55:03.459923Z","steps":["trace[1452351334] 'agreement among raft nodes before linearized reading' (duration: 136.110669ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:03.459379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.893184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5326"} {"level":"info","ts":"2026-06-24T00:55:03.460944Z","caller":"traceutil/trace.go:171","msg":"trace[1848438230] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:306; }","duration":"137.475022ms","start":"2026-06-24T00:55:03.323454Z","end":"2026-06-24T00:55:03.460929Z","steps":["trace[1848438230] 'agreement among raft nodes before linearized reading' (duration: 135.866364ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:03.45923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.069598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"} {"level":"info","ts":"2026-06-24T00:55:03.461081Z","caller":"traceutil/trace.go:171","msg":"trace[1583722849] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:306; }","duration":"137.903251ms","start":"2026-06-24T00:55:03.323129Z","end":"2026-06-24T00:55:03.461032Z","steps":["trace[1583722849] 'agreement among raft nodes before linearized reading' (duration: 135.992306ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:03.459449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.976283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7294"} {"level":"info","ts":"2026-06-24T00:55:03.461213Z","caller":"traceutil/trace.go:171","msg":"trace[2011525919] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:306; }","duration":"136.770424ms","start":"2026-06-24T00:55:03.324436Z","end":"2026-06-24T00:55:03.461206Z","steps":["trace[2011525919] 'agreement among raft nodes before linearized reading' (duration: 134.973892ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:03.721099Z","caller":"traceutil/trace.go:171","msg":"trace[17665884] linearizableReadLoop","detail":"{readStateIndex:324; appliedIndex:322; }","duration":"197.02352ms","start":"2026-06-24T00:55:03.524056Z","end":"2026-06-24T00:55:03.721079Z","steps":["trace[17665884] 'read index received' (duration: 191.758667ms)","trace[17665884] 'applied index is now lower than readState.Index' (duration: 5.263823ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:03.721257Z","caller":"traceutil/trace.go:171","msg":"trace[1486749249] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"236.399315ms","start":"2026-06-24T00:55:03.4848Z","end":"2026-06-24T00:55:03.721199Z","steps":["trace[1486749249] 'process raft request' (duration: 231.049849ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:03.721324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.942802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-24T00:55:03.721366Z","caller":"traceutil/trace.go:171","msg":"trace[705562802] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:310; }","duration":"201.221369ms","start":"2026-06-24T00:55:03.520135Z","end":"2026-06-24T00:55:03.721356Z","steps":["trace[705562802] 'agreement among raft nodes before linearized reading' (duration: 201.049545ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:03.721258Z","caller":"traceutil/trace.go:171","msg":"trace[1945910746] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"230.009294ms","start":"2026-06-24T00:55:03.491191Z","end":"2026-06-24T00:55:03.7212Z","steps":["trace[1945910746] 'process raft request' (duration: 229.83008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:03.733504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.441001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-06-24T00:55:03.733554Z","caller":"traceutil/trace.go:171","msg":"trace[7947982] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:311; }","duration":"163.518342ms","start":"2026-06-24T00:55:03.570023Z","end":"2026-06-24T00:55:03.733542Z","steps":["trace[7947982] 'agreement among raft nodes before linearized reading' (duration: 163.42554ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:03.733552Z","caller":"traceutil/trace.go:171","msg":"trace[986832760] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"204.933247ms","start":"2026-06-24T00:55:03.52857Z","end":"2026-06-24T00:55:03.733503Z","steps":["trace[986832760] 'process raft request' (duration: 204.750942ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:03.733636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.957604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-06-24T00:55:03.733694Z","caller":"traceutil/trace.go:171","msg":"trace[1633180620] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:311; }","duration":"113.065487ms","start":"2026-06-24T00:55:03.620615Z","end":"2026-06-24T00:55:03.733681Z","steps":["trace[1633180620] 'agreement among raft nodes before linearized reading' (duration: 112.975455ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:03.936872Z","caller":"traceutil/trace.go:171","msg":"trace[150617080] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"196.404895ms","start":"2026-06-24T00:55:03.740451Z","end":"2026-06-24T00:55:03.936856Z","steps":["trace[150617080] 'process raft request' (duration: 196.074498ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:03.937041Z","caller":"traceutil/trace.go:171","msg":"trace[519489325] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"195.148466ms","start":"2026-06-24T00:55:03.741853Z","end":"2026-06-24T00:55:03.937002Z","steps":["trace[519489325] 'process raft request' (duration: 194.936881ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:03.937041Z","caller":"traceutil/trace.go:171","msg":"trace[767920593] linearizableReadLoop","detail":"{readStateIndex:333; appliedIndex:328; }","duration":"127.510566ms","start":"2026-06-24T00:55:03.809452Z","end":"2026-06-24T00:55:03.936962Z","steps":["trace[767920593] 'read index received' (duration: 107.69227ms)","trace[767920593] 'applied index is now lower than readState.Index' (duration: 19.817096ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:03.936611Z","caller":"traceutil/trace.go:171","msg":"trace[1603974337] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"196.774685ms","start":"2026-06-24T00:55:03.739803Z","end":"2026-06-24T00:55:03.936577Z","steps":["trace[1603974337] 'process raft request' (duration: 177.297117ms)","trace[1603974337] 'compare' (duration: 19.304874ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:03.937472Z","caller":"traceutil/trace.go:171","msg":"trace[785832756] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"195.800752ms","start":"2026-06-24T00:55:03.741659Z","end":"2026-06-24T00:55:03.93746Z","steps":["trace[785832756] 'process raft request' (duration: 195.045424ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:03.937516Z","caller":"traceutil/trace.go:171","msg":"trace[386586596] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"193.769383ms","start":"2026-06-24T00:55:03.74373Z","end":"2026-06-24T00:55:03.937499Z","steps":["trace[386586596] 'process raft request' (duration: 193.165679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:03.937745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.982995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-24T00:55:03.937791Z","caller":"traceutil/trace.go:171","msg":"trace[2096418360] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:319; }","duration":"167.090677ms","start":"2026-06-24T00:55:03.77068Z","end":"2026-06-24T00:55:03.93777Z","steps":["trace[2096418360] 'agreement among raft nodes before linearized reading' (duration: 167.002835ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:03.940711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.198748ms","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-24T00:55:03.940331Z","caller":"traceutil/trace.go:171","msg":"trace[2000458127] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"125.888448ms","start":"2026-06-24T00:55:03.814404Z","end":"2026-06-24T00:55:03.940292Z","steps":["trace[2000458127] 'process raft request' (duration: 125.621782ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:03.94088Z","caller":"traceutil/trace.go:171","msg":"trace[1500250332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:323; }","duration":"121.377582ms","start":"2026-06-24T00:55:03.819461Z","end":"2026-06-24T00:55:03.940838Z","steps":["trace[1500250332] 'agreement among raft nodes before linearized reading' (duration: 120.85235ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:03.941646Z","caller":"traceutil/trace.go:171","msg":"trace[125529450] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"124.757852ms","start":"2026-06-24T00:55:03.816857Z","end":"2026-06-24T00:55:03.941615Z","steps":["trace[125529450] 'process raft request' (duration: 123.39951ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:03.942206Z","caller":"traceutil/trace.go:171","msg":"trace[1665258574] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"127.253521ms","start":"2026-06-24T00:55:03.814931Z","end":"2026-06-24T00:55:03.942185Z","steps":["trace[1665258574] 'process raft request' (duration: 125.274964ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:03.942508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.906699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-24T00:55:03.942762Z","caller":"traceutil/trace.go:171","msg":"trace[413627609] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:323; }","duration":"123.121133ms","start":"2026-06-24T00:55:03.819558Z","end":"2026-06-24T00:55:03.942679Z","steps":["trace[413627609] 'agreement among raft nodes before linearized reading' (duration: 122.058168ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:03.942604Z","caller":"traceutil/trace.go:171","msg":"trace[375484494] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"127.900646ms","start":"2026-06-24T00:55:03.814409Z","end":"2026-06-24T00:55:03.94231Z","steps":["trace[375484494] 'process raft request' (duration: 125.732555ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:04.378596Z","caller":"traceutil/trace.go:171","msg":"trace[1311187350] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"163.248596ms","start":"2026-06-24T00:55:04.215321Z","end":"2026-06-24T00:55:04.37857Z","steps":["trace[1311187350] 'process raft request' (duration: 162.98206ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:06.084431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.691407ms","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-24T00:55:06.084522Z","caller":"traceutil/trace.go:171","msg":"trace[16675179] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:362; }","duration":"123.83847ms","start":"2026-06-24T00:55:05.960665Z","end":"2026-06-24T00:55:06.084504Z","steps":["trace[16675179] 'range keys from in-memory index tree' (duration: 123.557204ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:18.35181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.041867ms","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-24T00:55:18.35191Z","caller":"traceutil/trace.go:171","msg":"trace[658190582] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:392; }","duration":"176.17141ms","start":"2026-06-24T00:55:18.175715Z","end":"2026-06-24T00:55:18.351887Z","steps":["trace[658190582] 'range keys from in-memory index tree' (duration: 175.976115ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:18.352152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.41744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-24T00:55:18.352137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.56166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-24T00:55:18.35237Z","caller":"traceutil/trace.go:171","msg":"trace[1715864540] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:392; }","duration":"497.747788ms","start":"2026-06-24T00:55:17.854489Z","end":"2026-06-24T00:55:18.352237Z","steps":["trace[1715864540] 'range keys from in-memory index tree' (duration: 497.324018ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:18.352383Z","caller":"traceutil/trace.go:171","msg":"trace[435909430] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:392; }","duration":"176.855697ms","start":"2026-06-24T00:55:18.17549Z","end":"2026-06-24T00:55:18.352346Z","steps":["trace[435909430] 'range keys from in-memory index tree' (duration: 176.434617ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:18.352492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:17.854468Z","time spent":"497.997245ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-24T00:55:18.566412Z","caller":"traceutil/trace.go:171","msg":"trace[1360167865] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"210.644921ms","start":"2026-06-24T00:55:18.355741Z","end":"2026-06-24T00:55:18.566386Z","steps":["trace[1360167865] 'process raft request' (duration: 210.491457ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:18.570428Z","caller":"traceutil/trace.go:171","msg":"trace[1718071377] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"214.663695ms","start":"2026-06-24T00:55:18.35573Z","end":"2026-06-24T00:55:18.570394Z","steps":["trace[1718071377] 'process raft request' (duration: 214.476451ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:18.570487Z","caller":"traceutil/trace.go:171","msg":"trace[1850765531] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"213.476457ms","start":"2026-06-24T00:55:18.356987Z","end":"2026-06-24T00:55:18.570463Z","steps":["trace[1850765531] 'process raft request' (duration: 213.312013ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:26.910901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.800985ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:55:26.911226Z","caller":"traceutil/trace.go:171","msg":"trace[18058289] linearizableReadLoop","detail":"{readStateIndex:462; appliedIndex:460; }","duration":"136.700363ms","start":"2026-06-24T00:55:26.774501Z","end":"2026-06-24T00:55:26.911201Z","steps":["trace[18058289] 'read index received' (duration: 37.861µs)","trace[18058289] 'applied index is now lower than readState.Index' (duration: 136.661202ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:26.911199Z","caller":"traceutil/trace.go:171","msg":"trace[324071065] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"304.2132ms","start":"2026-06-24T00:55:26.60694Z","end":"2026-06-24T00:55:26.911153Z","steps":["trace[324071065] 'process raft request' (duration: 129.740509ms)","trace[324071065] 'compare' (duration: 173.59532ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:55:26.911419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:26.606911Z","time spent":"304.380664ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:55:26.91143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.885377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T00:55:26.911476Z","caller":"traceutil/trace.go:171","msg":"trace[1519284070] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:443; }","duration":"137.0174ms","start":"2026-06-24T00:55:26.774445Z","end":"2026-06-24T00:55:26.911462Z","steps":["trace[1519284070] 'agreement among raft nodes before linearized reading' (duration: 136.830586ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:26.911511Z","caller":"traceutil/trace.go:171","msg":"trace[9443468] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"304.370833ms","start":"2026-06-24T00:55:26.607095Z","end":"2026-06-24T00:55:26.911465Z","steps":["trace[9443468] 'process raft request' (duration: 303.974604ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:26.911686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:26.607083Z","time spent":"304.510646ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:55:28.924183Z","caller":"traceutil/trace.go:171","msg":"trace[1905514964] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"283.695337ms","start":"2026-06-24T00:55:28.64047Z","end":"2026-06-24T00:55:28.924165Z","steps":["trace[1905514964] 'process raft request' (duration: 283.570314ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:29.652926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.63642ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:55:29.653052Z","caller":"traceutil/trace.go:171","msg":"trace[793690318] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"725.477599ms","start":"2026-06-24T00:55:28.927555Z","end":"2026-06-24T00:55:29.653032Z","steps":["trace[793690318] 'process raft request' (duration: 540.647166ms)","trace[793690318] 'compare' (duration: 184.521906ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:55:29.65312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:28.927537Z","time spent":"725.553042ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:55:29.700388Z","caller":"traceutil/trace.go:171","msg":"trace[2097536217] linearizableReadLoop","detail":"{readStateIndex:469; appliedIndex:467; }","duration":"141.460105ms","start":"2026-06-24T00:55:29.558904Z","end":"2026-06-24T00:55:29.700364Z","steps":["trace[2097536217] 'read index received' (duration: 141.220179ms)","trace[2097536217] 'applied index is now lower than readState.Index' (duration: 238.826µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:55:29.700503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.584788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:29.70055Z","caller":"traceutil/trace.go:171","msg":"trace[2120522147] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:449; }","duration":"141.655869ms","start":"2026-06-24T00:55:29.558878Z","end":"2026-06-24T00:55:29.700533Z","steps":["trace[2120522147] 'agreement among raft nodes before linearized reading' (duration: 141.580907ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:29.700584Z","caller":"traceutil/trace.go:171","msg":"trace[1868940192] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"772.897345ms","start":"2026-06-24T00:55:28.92767Z","end":"2026-06-24T00:55:29.700567Z","steps":["trace[1868940192] 'process raft request' (duration: 772.511196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:29.700673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:28.927645Z","time spent":"772.976606ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:55:29.700791Z","caller":"traceutil/trace.go:171","msg":"trace[411432307] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"771.696956ms","start":"2026-06-24T00:55:28.929077Z","end":"2026-06-24T00:55:29.700774Z","steps":["trace[411432307] 'process raft request' (duration: 771.225785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:29.700881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:28.929064Z","time spent":"771.765598ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:55:30.153136Z","caller":"traceutil/trace.go:171","msg":"trace[1964216118] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"186.444942ms","start":"2026-06-24T00:55:29.966668Z","end":"2026-06-24T00:55:30.153113Z","steps":["trace[1964216118] 'process raft request' (duration: 180.83713ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:39.827434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.071699ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:55:39.827609Z","caller":"traceutil/trace.go:171","msg":"trace[2094196731] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"861.795212ms","start":"2026-06-24T00:55:38.965798Z","end":"2026-06-24T00:55:39.827594Z","steps":["trace[2094196731] 'process raft request' (duration: 861.739701ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:39.82767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:38.965768Z","time spent":"861.876314ms","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:55:39.827664Z","caller":"traceutil/trace.go:171","msg":"trace[678492201] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"861.828724ms","start":"2026-06-24T00:55:38.965785Z","end":"2026-06-24T00:55:39.827614Z","steps":["trace[678492201] 'process raft request' (duration: 399.462587ms)","trace[678492201] 'compare' (duration: 461.946317ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:55:39.827803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:38.965766Z","time spent":"861.979247ms","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:55:40.247785Z","caller":"traceutil/trace.go:171","msg":"trace[171084112] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"1.269549266s","start":"2026-06-24T00:55:38.978204Z","end":"2026-06-24T00:55:40.247754Z","steps":["trace[171084112] 'process raft request' (duration: 1.26718549s)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:40.247817Z","caller":"traceutil/trace.go:171","msg":"trace[1806996222] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"1.268613094s","start":"2026-06-24T00:55:38.979181Z","end":"2026-06-24T00:55:40.247794Z","steps":["trace[1806996222] 'process raft request' (duration: 1.268490851s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.247949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:38.979175Z","time spent":"1.268702416s","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:55:40.248639Z","caller":"traceutil/trace.go:171","msg":"trace[1964321969] transaction","detail":"{read_only:false; number_of_response:1; response_revision:508; }","duration":"1.267333594s","start":"2026-06-24T00:55:38.981276Z","end":"2026-06-24T00:55:40.24861Z","steps":["trace[1964321969] 'process raft request' (duration: 1.266855303s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.248821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:38.981272Z","time spent":"1.267452397s","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6938,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:55:40.249005Z","caller":"traceutil/trace.go:171","msg":"trace[1419533387] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"1.267825135s","start":"2026-06-24T00:55:38.981164Z","end":"2026-06-24T00:55:40.248989Z","steps":["trace[1419533387] 'process raft request' (duration: 1.266587446s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.249079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:38.981156Z","time spent":"1.267889117s","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:55:40.249214Z","caller":"traceutil/trace.go:171","msg":"trace[647734173] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"1.267072288s","start":"2026-06-24T00:55:38.982126Z","end":"2026-06-24T00:55:40.249198Z","steps":["trace[647734173] 'process raft request' (duration: 1.266211478s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.251153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:38.978187Z","time spent":"1.269680889s","remote":"127.0.0.1:51400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:55:40.2514Z","caller":"traceutil/trace.go:171","msg":"trace[1455635945] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"1.259415268s","start":"2026-06-24T00:55:38.991939Z","end":"2026-06-24T00:55:40.251354Z","steps":["trace[1455635945] 'process raft request' (duration: 1.257269387s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.251596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:38.99193Z","time spent":"1.259574531s","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:55:40.251793Z","caller":"traceutil/trace.go:171","msg":"trace[756114257] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"1.263958945s","start":"2026-06-24T00:55:38.987821Z","end":"2026-06-24T00:55:40.25178Z","steps":["trace[756114257] 'process raft request' (duration: 1.260728099s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.251923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:38.987792Z","time spent":"1.264079927s","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T00:55:40.252994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:38.982118Z","time spent":"1.267138509s","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:55:40.254043Z","caller":"traceutil/trace.go:171","msg":"trace[1338606697] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"1.262965781s","start":"2026-06-24T00:55:38.989122Z","end":"2026-06-24T00:55:40.252088Z","steps":["trace[1338606697] 'process raft request' (duration: 1.259711914s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.25417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:38.989106Z","time spent":"1.264994759s","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:55:40.254371Z","caller":"traceutil/trace.go:171","msg":"trace[562524249] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"1.26038313s","start":"2026-06-24T00:55:38.993775Z","end":"2026-06-24T00:55:40.254158Z","steps":["trace[562524249] 'process raft request' (duration: 1.259379587s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.254493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:38.993758Z","time spent":"1.260678707s","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:55:40.255629Z","caller":"traceutil/trace.go:171","msg":"trace[330012467] linearizableReadLoop","detail":"{readStateIndex:528; appliedIndex:525; }","duration":"1.27735917s","start":"2026-06-24T00:55:38.978225Z","end":"2026-06-24T00:55:40.255584Z","steps":["trace[330012467] 'read index received' (duration: 387.093187ms)","trace[330012467] 'applied index is now lower than readState.Index' (duration: 890.14418ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:40.257302Z","caller":"traceutil/trace.go:171","msg":"trace[683721570] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"1.107859736s","start":"2026-06-24T00:55:39.149422Z","end":"2026-06-24T00:55:40.257282Z","steps":["trace[683721570] 'process raft request' (duration: 1.105663734s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.257393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:39.149399Z","time spent":"1.107952697s","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:55:40.257537Z","caller":"traceutil/trace.go:171","msg":"trace[829739079] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"1.243272378s","start":"2026-06-24T00:55:39.014246Z","end":"2026-06-24T00:55:40.257519Z","steps":["trace[829739079] 'process raft request' (duration: 1.239618562s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.25758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:39.014221Z","time spent":"1.243342249s","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:55:40.258049Z","caller":"traceutil/trace.go:171","msg":"trace[978844669] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"1.258800793s","start":"2026-06-24T00:55:38.999043Z","end":"2026-06-24T00:55:40.257844Z","steps":["trace[978844669] 'process raft request' (duration: 1.254269006s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.258184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.279949941s","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-24T00:55:40.258178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:38.999021Z","time spent":"1.259115821s","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:55:40.258222Z","caller":"traceutil/trace.go:171","msg":"trace[346686971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:516; }","duration":"1.280022942s","start":"2026-06-24T00:55:38.97819Z","end":"2026-06-24T00:55:40.258213Z","steps":["trace[346686971] 'agreement among raft nodes before linearized reading' (duration: 1.279569901s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.258249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:38.978173Z","time spent":"1.280066113s","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T00:55:40.982972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.156603ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:55:40.983646Z","caller":"traceutil/trace.go:171","msg":"trace[914888467] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"1.150063729s","start":"2026-06-24T00:55:39.833559Z","end":"2026-06-24T00:55:40.983623Z","steps":["trace[914888467] 'process raft request' (duration: 1.149914985s)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:40.983658Z","caller":"traceutil/trace.go:171","msg":"trace[1352886161] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"1.150158031s","start":"2026-06-24T00:55:39.833476Z","end":"2026-06-24T00:55:40.983634Z","steps":["trace[1352886161] 'process raft request' (duration: 898.277841ms)","trace[1352886161] 'compare' (duration: 251.03122ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:40.983693Z","caller":"traceutil/trace.go:171","msg":"trace[1276758550] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"1.145985323s","start":"2026-06-24T00:55:39.837678Z","end":"2026-06-24T00:55:40.983664Z","steps":["trace[1276758550] 'process raft request' (duration: 1.14585345s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.983747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:39.833552Z","time spent":"1.15014447s","remote":"127.0.0.1:51400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T00:55:40.98375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:39.833458Z","time spent":"1.150247873s","remote":"127.0.0.1:51400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:55:40.983802Z","caller":"traceutil/trace.go:171","msg":"trace[339926776] linearizableReadLoop","detail":"{readStateIndex:542; appliedIndex:539; }","duration":"728.096951ms","start":"2026-06-24T00:55:40.255662Z","end":"2026-06-24T00:55:40.983759Z","steps":["trace[339926776] 'read index received' (duration: 476.15611ms)","trace[339926776] 'applied index is now lower than readState.Index' (duration: 251.935211ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:55:40.983863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:39.837662Z","time spent":"1.146114166s","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:55:40.983982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.54413683s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:40.984039Z","caller":"traceutil/trace.go:171","msg":"trace[501814471] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:520; }","duration":"1.544247152s","start":"2026-06-24T00:55:39.439774Z","end":"2026-06-24T00:55:40.984022Z","steps":["trace[501814471] 'agreement among raft nodes before linearized reading' (duration: 1.544114709s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.984094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:39.439755Z","time spent":"1.544326914s","remote":"127.0.0.1:50830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T00:55:40.984074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.174185155s","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-24T00:55:40.984165Z","caller":"traceutil/trace.go:171","msg":"trace[1615708314] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:520; }","duration":"1.174318649s","start":"2026-06-24T00:55:39.809819Z","end":"2026-06-24T00:55:40.984137Z","steps":["trace[1615708314] 'agreement among raft nodes before linearized reading' (duration: 1.173996771s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.984185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.17098546s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-24T00:55:40.984219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:39.809798Z","time spent":"1.1744066s","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-24T00:55:40.984229Z","caller":"traceutil/trace.go:171","msg":"trace[18342249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:520; }","duration":"1.171079543s","start":"2026-06-24T00:55:39.813137Z","end":"2026-06-24T00:55:40.984216Z","steps":["trace[18342249] 'agreement among raft nodes before linearized reading' (duration: 1.170919649s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.984273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:39.813115Z","time spent":"1.171150914s","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T00:55:40.984348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.425220705s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:40.984394Z","caller":"traceutil/trace.go:171","msg":"trace[620414637] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:520; }","duration":"1.425301667s","start":"2026-06-24T00:55:39.559081Z","end":"2026-06-24T00:55:40.984383Z","steps":["trace[620414637] 'agreement among raft nodes before linearized reading' (duration: 1.425228415s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.984424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:39.559031Z","time spent":"1.425386459s","remote":"127.0.0.1:50836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T00:55:40.984575Z","caller":"traceutil/trace.go:171","msg":"trace[1540746410] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"727.373674ms","start":"2026-06-24T00:55:40.257177Z","end":"2026-06-24T00:55:40.984551Z","steps":["trace[1540746410] 'process raft request' (duration: 726.405402ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.984704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:40.257159Z","time spent":"727.485337ms","remote":"127.0.0.1:51400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T00:55:40.98445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.298348023s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T00:55:40.985256Z","caller":"traceutil/trace.go:171","msg":"trace[887674608] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:520; }","duration":"1.299180563s","start":"2026-06-24T00:55:39.686056Z","end":"2026-06-24T00:55:40.985236Z","steps":["trace[887674608] 'agreement among raft nodes before linearized reading' (duration: 1.298301202s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.98532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:39.686041Z","time spent":"1.299260895s","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T00:55:40.987439Z","caller":"traceutil/trace.go:171","msg":"trace[1627341038] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"725.987432ms","start":"2026-06-24T00:55:40.261438Z","end":"2026-06-24T00:55:40.987425Z","steps":["trace[1627341038] 'process raft request' (duration: 722.183363ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.987524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:40.261416Z","time spent":"726.060483ms","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:55:40.988389Z","caller":"traceutil/trace.go:171","msg":"trace[1670873403] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"726.589416ms","start":"2026-06-24T00:55:40.261776Z","end":"2026-06-24T00:55:40.988366Z","steps":["trace[1670873403] 'process raft request' (duration: 725.577852ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.988812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:40.261765Z","time spent":"726.974595ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:55:40.988667Z","caller":"traceutil/trace.go:171","msg":"trace[1791562957] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"726.347511ms","start":"2026-06-24T00:55:40.262295Z","end":"2026-06-24T00:55:40.988643Z","steps":["trace[1791562957] 'process raft request' (duration: 725.91696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.989943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:40.262285Z","time spent":"727.59024ms","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:55:40.989193Z","caller":"traceutil/trace.go:171","msg":"trace[764820460] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"726.404102ms","start":"2026-06-24T00:55:40.262763Z","end":"2026-06-24T00:55:40.989167Z","steps":["trace[764820460] 'process raft request' (duration: 725.830348ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:40.989243Z","caller":"traceutil/trace.go:171","msg":"trace[1439853754] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"723.281209ms","start":"2026-06-24T00:55:40.265955Z","end":"2026-06-24T00:55:40.989236Z","steps":["trace[1439853754] 'process raft request' (duration: 722.844688ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.990095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:40.262753Z","time spent":"727.281162ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:55:40.990173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:40.265924Z","time spent":"724.204929ms","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:55:40.989597Z","caller":"traceutil/trace.go:171","msg":"trace[2106688770] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"717.963163ms","start":"2026-06-24T00:55:40.271625Z","end":"2026-06-24T00:55:40.989588Z","steps":["trace[2106688770] 'process raft request' (duration: 717.453661ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.990376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:40.27161Z","time spent":"718.737801ms","remote":"127.0.0.1:51400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:55:40.989656Z","caller":"traceutil/trace.go:171","msg":"trace[1070555247] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"703.448912ms","start":"2026-06-24T00:55:40.286196Z","end":"2026-06-24T00:55:40.989645Z","steps":["trace[1070555247] 'process raft request' (duration: 703.326559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.990496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:40.286175Z","time spent":"704.271031ms","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:55:40.989688Z","caller":"traceutil/trace.go:171","msg":"trace[467419351] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"713.350284ms","start":"2026-06-24T00:55:40.276331Z","end":"2026-06-24T00:55:40.989681Z","steps":["trace[467419351] 'process raft request' (duration: 713.123059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.990617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:40.276309Z","time spent":"714.276126ms","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:55:40.989757Z","caller":"traceutil/trace.go:171","msg":"trace[258541512] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"682.123101ms","start":"2026-06-24T00:55:40.307626Z","end":"2026-06-24T00:55:40.989749Z","steps":["trace[258541512] 'process raft request' (duration: 681.987257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:40.990858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:40.307593Z","time spent":"683.069303ms","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:55:42.282959Z","caller":"traceutil/trace.go:171","msg":"trace[1271701612] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"243.412141ms","start":"2026-06-24T00:55:42.039524Z","end":"2026-06-24T00:55:42.282936Z","steps":["trace[1271701612] 'read index received' (duration: 240.032401ms)","trace[1271701612] 'applied index is now lower than readState.Index' (duration: 3.37883ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:55:42.283137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.596525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-06-24T00:55:42.283195Z","caller":"traceutil/trace.go:171","msg":"trace[14827312] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:579; }","duration":"243.683056ms","start":"2026-06-24T00:55:42.039499Z","end":"2026-06-24T00:55:42.283182Z","steps":["trace[14827312] 'agreement among raft nodes before linearized reading' (duration: 243.519473ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:42.283426Z","caller":"traceutil/trace.go:171","msg":"trace[2137720235] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"271.191874ms","start":"2026-06-24T00:55:42.012207Z","end":"2026-06-24T00:55:42.283399Z","steps":["trace[2137720235] 'process raft request' (duration: 267.333112ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:42.382833Z","caller":"traceutil/trace.go:171","msg":"trace[120152599] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"293.960789ms","start":"2026-06-24T00:55:42.088851Z","end":"2026-06-24T00:55:42.382812Z","steps":["trace[120152599] 'process raft request' (duration: 293.635371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:42.407492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.04858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31145"} {"level":"info","ts":"2026-06-24T00:55:42.407557Z","caller":"traceutil/trace.go:171","msg":"trace[493256646] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:580; }","duration":"111.151602ms","start":"2026-06-24T00:55:42.296389Z","end":"2026-06-24T00:55:42.40754Z","steps":["trace[493256646] 'agreement among raft nodes before linearized reading' (duration: 86.40047ms)","trace[493256646] 'range keys from in-memory index tree' (duration: 24.549457ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:44.190461Z","caller":"traceutil/trace.go:171","msg":"trace[656120962] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"133.227311ms","start":"2026-06-24T00:55:44.057208Z","end":"2026-06-24T00:55:44.190435Z","steps":["trace[656120962] 'process raft request' (duration: 109.646707ms)","trace[656120962] 'compare' (duration: 23.479181ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:44.19729Z","caller":"traceutil/trace.go:171","msg":"trace[676217742] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"139.502778ms","start":"2026-06-24T00:55:44.057764Z","end":"2026-06-24T00:55:44.197266Z","steps":["trace[676217742] 'process raft request' (duration: 139.387805ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:46.21667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.08925ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:55:46.216745Z","caller":"traceutil/trace.go:171","msg":"trace[1754902100] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:624; }","duration":"657.454781ms","start":"2026-06-24T00:55:45.559278Z","end":"2026-06-24T00:55:46.216732Z","steps":["trace[1754902100] 'read index received' (duration: 95.155526ms)","trace[1754902100] 'applied index is now lower than readState.Index' (duration: 562.298215ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:55:46.21682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"657.543093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:46.216836Z","caller":"traceutil/trace.go:171","msg":"trace[1014826967] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:598; }","duration":"657.594054ms","start":"2026-06-24T00:55:45.559236Z","end":"2026-06-24T00:55:46.21683Z","steps":["trace[1014826967] 'agreement among raft nodes before linearized reading' (duration: 657.539723ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:46.216855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:45.559222Z","time spent":"657.628375ms","remote":"127.0.0.1:50830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T00:55:46.216898Z","caller":"traceutil/trace.go:171","msg":"trace[1092948797] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"717.067372ms","start":"2026-06-24T00:55:45.49979Z","end":"2026-06-24T00:55:46.216858Z","steps":["trace[1092948797] 'process raft request' (duration: 154.745996ms)","trace[1092948797] 'compare' (duration: 561.708851ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:55:46.217044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:45.499765Z","time spent":"717.212655ms","remote":"127.0.0.1:51176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:55:47.824487Z","caller":"traceutil/trace.go:171","msg":"trace[139907168] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"239.352325ms","start":"2026-06-24T00:55:47.58511Z","end":"2026-06-24T00:55:47.824462Z","steps":["trace[139907168] 'process raft request' (duration: 238.767022ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:48.519101Z","caller":"traceutil/trace.go:171","msg":"trace[871631259] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"216.445496ms","start":"2026-06-24T00:55:48.302631Z","end":"2026-06-24T00:55:48.519077Z","steps":["trace[871631259] 'read index received' (duration: 216.307113ms)","trace[871631259] 'applied index is now lower than readState.Index' (duration: 137.223µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:48.519208Z","caller":"traceutil/trace.go:171","msg":"trace[1883530907] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"638.951487ms","start":"2026-06-24T00:55:47.880228Z","end":"2026-06-24T00:55:48.51918Z","steps":["trace[1883530907] 'process raft request' (duration: 638.702161ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:48.519318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.664752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8gvjm\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-24T00:55:48.51936Z","caller":"traceutil/trace.go:171","msg":"trace[2138237964] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8gvjm; range_end:; response_count:1; response_revision:613; }","duration":"216.723724ms","start":"2026-06-24T00:55:48.302623Z","end":"2026-06-24T00:55:48.519347Z","steps":["trace[2138237964] 'agreement among raft nodes before linearized reading' (duration: 216.544179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:48.51936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:47.880205Z","time spent":"639.087329ms","remote":"127.0.0.1:51196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T00:55:48.640328Z","caller":"traceutil/trace.go:171","msg":"trace[1532637933] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"106.189125ms","start":"2026-06-24T00:55:48.534101Z","end":"2026-06-24T00:55:48.64029Z","steps":["trace[1532637933] 'process raft request' (duration: 29.756119ms)","trace[1532637933] 'compare' (duration: 76.201271ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:55:49.536431Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256279706445090366,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:55:50.037478Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256279706445090366,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:55:50.538314Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256279706445090366,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:55:51.038448Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256279706445090366,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:55:51.052904Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.127910719s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T00:55:51.082655Z","caller":"traceutil/trace.go:171","msg":"trace[487008634] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"2.04658944s","start":"2026-06-24T00:55:49.036037Z","end":"2026-06-24T00:55:51.082626Z","steps":["trace[487008634] 'read index received' (duration: 2.017049024s)","trace[487008634] 'applied index is now lower than readState.Index' (duration: 29.539386ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:51.082742Z","caller":"traceutil/trace.go:171","msg":"trace[1673321474] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"2.164141823s","start":"2026-06-24T00:55:48.918581Z","end":"2026-06-24T00:55:51.082723Z","steps":["trace[1673321474] 'process raft request' (duration: 2.134774671s)","trace[1673321474] 'compare' (duration: 28.42985ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:55:51.082853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:48.918553Z","time spent":"2.164232165s","remote":"127.0.0.1:50908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:55:51.082879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.046825905s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-24T00:55:51.082951Z","caller":"traceutil/trace.go:171","msg":"trace[978757497] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:615; }","duration":"2.046955258s","start":"2026-06-24T00:55:49.035977Z","end":"2026-06-24T00:55:51.082933Z","steps":["trace[978757497] 'agreement among raft nodes before linearized reading' (duration: 2.046762194s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:51.082982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:49.035956Z","time spent":"2.04701964s","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T00:55:51.08305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.025948735s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-24T00:55:51.083141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.026058748s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-24T00:55:51.08313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.524196293s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:51.083152Z","caller":"traceutil/trace.go:171","msg":"trace[155637507] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:615; }","duration":"2.026108059s","start":"2026-06-24T00:55:49.057017Z","end":"2026-06-24T00:55:51.083125Z","steps":["trace[155637507] 'agreement among raft nodes before linearized reading' (duration: 2.025787981s)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:51.08317Z","caller":"traceutil/trace.go:171","msg":"trace[67097415] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:615; }","duration":"2.026087299s","start":"2026-06-24T00:55:49.057073Z","end":"2026-06-24T00:55:51.083161Z","steps":["trace[67097415] 'agreement among raft nodes before linearized reading' (duration: 2.025983356s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:51.083078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.025134746s","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-24T00:55:51.083181Z","caller":"traceutil/trace.go:171","msg":"trace[791212302] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"1.524273595s","start":"2026-06-24T00:55:49.558893Z","end":"2026-06-24T00:55:51.083167Z","steps":["trace[791212302] 'agreement among raft nodes before linearized reading' (duration: 1.524217784s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:51.083194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:49.057027Z","time spent":"2.02616289s","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T00:55:51.0832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:49.056996Z","time spent":"2.026194241s","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-24T00:55:51.083209Z","caller":"traceutil/trace.go:171","msg":"trace[484935291] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:615; }","duration":"2.025310381s","start":"2026-06-24T00:55:49.057887Z","end":"2026-06-24T00:55:51.083197Z","steps":["trace[484935291] 'agreement among raft nodes before linearized reading' (duration: 2.025051874s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:51.083215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:49.55887Z","time spent":"1.524338317s","remote":"127.0.0.1:50830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T00:55:51.08324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:49.057867Z","time spent":"2.025362671s","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T00:55:52.50619Z","caller":"traceutil/trace.go:171","msg":"trace[2055845608] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"156.574542ms","start":"2026-06-24T00:55:52.349599Z","end":"2026-06-24T00:55:52.506173Z","steps":["trace[2055845608] 'process raft request' (duration: 156.49173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:52.506281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.67317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:52.50633Z","caller":"traceutil/trace.go:171","msg":"trace[1144218610] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:646; }","duration":"152.781722ms","start":"2026-06-24T00:55:52.353536Z","end":"2026-06-24T00:55:52.506318Z","steps":["trace[1144218610] 'agreement among raft nodes before linearized reading' (duration: 152.67084ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:52.506371Z","caller":"traceutil/trace.go:171","msg":"trace[410015815] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"157.33657ms","start":"2026-06-24T00:55:52.349025Z","end":"2026-06-24T00:55:52.506362Z","steps":["trace[410015815] 'process raft request' (duration: 86.486689ms)","trace[410015815] 'compare' (duration: 70.455721ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:52.506186Z","caller":"traceutil/trace.go:171","msg":"trace[1628246787] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:671; }","duration":"152.579758ms","start":"2026-06-24T00:55:52.353582Z","end":"2026-06-24T00:55:52.506162Z","steps":["trace[1628246787] 'read index received' (duration: 81.942842ms)","trace[1628246787] 'applied index is now lower than readState.Index' (duration: 70.635986ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:55:52.50647Z","caller":"traceutil/trace.go:171","msg":"trace[355056401] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"153.624912ms","start":"2026-06-24T00:55:52.352835Z","end":"2026-06-24T00:55:52.50646Z","steps":["trace[355056401] 'process raft request' (duration: 153.292814ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:52.526053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.943764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:52.526128Z","caller":"traceutil/trace.go:171","msg":"trace[2117070252] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:648; }","duration":"172.035416ms","start":"2026-06-24T00:55:52.354076Z","end":"2026-06-24T00:55:52.526112Z","steps":["trace[2117070252] 'agreement among raft nodes before linearized reading' (duration: 171.922324ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:52.526136Z","caller":"traceutil/trace.go:171","msg":"trace[798496485] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"170.000568ms","start":"2026-06-24T00:55:52.356124Z","end":"2026-06-24T00:55:52.526124Z","steps":["trace[798496485] 'process raft request' (duration: 169.753653ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:52.526709Z","caller":"traceutil/trace.go:171","msg":"trace[1721463641] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"169.686041ms","start":"2026-06-24T00:55:52.356402Z","end":"2026-06-24T00:55:52.526088Z","steps":["trace[1721463641] 'process raft request' (duration: 169.547307ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:53.041026Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256279706445090423,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T00:55:53.2937Z","caller":"traceutil/trace.go:171","msg":"trace[1666417682] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"760.486501ms","start":"2026-06-24T00:55:52.53319Z","end":"2026-06-24T00:55:53.293677Z","steps":["trace[1666417682] 'process raft request' (duration: 760.353018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:53.293872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:52.533135Z","time spent":"760.643335ms","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5162,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:55:53.3548Z","caller":"traceutil/trace.go:171","msg":"trace[1182393315] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"820.70718ms","start":"2026-06-24T00:55:52.534016Z","end":"2026-06-24T00:55:53.354724Z","steps":["trace[1182393315] 'process raft request' (duration: 819.667206ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:53.35561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:52.533978Z","time spent":"821.54104ms","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4156,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:55:53.41803Z","caller":"traceutil/trace.go:171","msg":"trace[2060266217] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:678; }","duration":"877.487179ms","start":"2026-06-24T00:55:52.540475Z","end":"2026-06-24T00:55:53.417963Z","steps":["trace[2060266217] 'read index received' (duration: 753.045595ms)","trace[2060266217] 'applied index is now lower than readState.Index' (duration: 124.439874ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:55:53.418076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"877.567031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:53.418156Z","caller":"traceutil/trace.go:171","msg":"trace[1559144096] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:652; }","duration":"877.692235ms","start":"2026-06-24T00:55:52.54045Z","end":"2026-06-24T00:55:53.418142Z","steps":["trace[1559144096] 'agreement among raft nodes before linearized reading' (duration: 877.527821ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:53.4182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:52.540437Z","time spent":"877.744876ms","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"info","ts":"2026-06-24T00:55:53.49366Z","caller":"traceutil/trace.go:171","msg":"trace[71119223] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"132.146866ms","start":"2026-06-24T00:55:53.361486Z","end":"2026-06-24T00:55:53.493632Z","steps":["trace[71119223] 'process raft request' (duration: 131.414038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:53.504925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"945.800111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:53.504977Z","caller":"traceutil/trace.go:171","msg":"trace[1692455251] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:655; }","duration":"945.883452ms","start":"2026-06-24T00:55:52.559084Z","end":"2026-06-24T00:55:53.504967Z","steps":["trace[1692455251] 'agreement among raft nodes before linearized reading' (duration: 945.79411ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:53.504998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:52.559073Z","time spent":"945.920264ms","remote":"127.0.0.1:50836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T00:55:53.505128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.846015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:53.505151Z","caller":"traceutil/trace.go:171","msg":"trace[1792762394] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:655; }","duration":"563.914896ms","start":"2026-06-24T00:55:52.941229Z","end":"2026-06-24T00:55:53.505144Z","steps":["trace[1792762394] 'agreement among raft nodes before linearized reading' (duration: 563.875965ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:53.505168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:52.941211Z","time spent":"563.953187ms","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"warn","ts":"2026-06-24T00:55:53.505163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.040795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:53.505219Z","caller":"traceutil/trace.go:171","msg":"trace[1143182957] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"142.281925ms","start":"2026-06-24T00:55:53.362919Z","end":"2026-06-24T00:55:53.505201Z","steps":["trace[1143182957] 'process raft request' (duration: 141.858445ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:53.505242Z","caller":"traceutil/trace.go:171","msg":"trace[222593150] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:655; }","duration":"163.164307ms","start":"2026-06-24T00:55:53.342058Z","end":"2026-06-24T00:55:53.505222Z","steps":["trace[222593150] 'agreement among raft nodes before linearized reading' (duration: 163.055485ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:53.505276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.531604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-8qjmc\" ","response":"range_response_count:1 size:4884"} {"level":"info","ts":"2026-06-24T00:55:53.505299Z","caller":"traceutil/trace.go:171","msg":"trace[408071996] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-8qjmc; range_end:; response_count:1; response_revision:655; }","duration":"741.594036ms","start":"2026-06-24T00:55:52.763699Z","end":"2026-06-24T00:55:53.505293Z","steps":["trace[408071996] 'agreement among raft nodes before linearized reading' (duration: 741.534434ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:53.505318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:52.763679Z","time spent":"741.635036ms","remote":"127.0.0.1:51012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4908,"request content":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-8qjmc\" "} {"level":"warn","ts":"2026-06-24T00:55:53.505209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.934026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-24T00:55:53.505398Z","caller":"traceutil/trace.go:171","msg":"trace[1033755770] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:655; }","duration":"410.160191ms","start":"2026-06-24T00:55:53.095229Z","end":"2026-06-24T00:55:53.505389Z","steps":["trace[1033755770] 'agreement among raft nodes before linearized reading' (duration: 409.821573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:53.505439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:53.095204Z","time spent":"410.226013ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T00:55:53.505496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.507201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:53.505519Z","caller":"traceutil/trace.go:171","msg":"trace[1845305373] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:655; }","duration":"363.553002ms","start":"2026-06-24T00:55:53.141961Z","end":"2026-06-24T00:55:53.505514Z","steps":["trace[1845305373] 'agreement among raft nodes before linearized reading' (duration: 363.519581ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:53.505539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:53.141947Z","time spent":"363.588213ms","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-06-24T00:55:53.505534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.749231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:55:53.505639Z","caller":"traceutil/trace.go:171","msg":"trace[1842392897] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:0; response_revision:655; }","duration":"764.889065ms","start":"2026-06-24T00:55:52.740742Z","end":"2026-06-24T00:55:53.505631Z","steps":["trace[1842392897] 'agreement among raft nodes before linearized reading' (duration: 764.766682ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:53.505663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:52.740726Z","time spent":"764.928266ms","remote":"127.0.0.1:50860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "} {"level":"warn","ts":"2026-06-24T00:55:53.505704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.899824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-24T00:55:53.505743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.865523ms","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-24T00:55:53.505742Z","caller":"traceutil/trace.go:171","msg":"trace[629389060] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:655; }","duration":"406.962825ms","start":"2026-06-24T00:55:53.098769Z","end":"2026-06-24T00:55:53.505732Z","steps":["trace[629389060] 'agreement among raft nodes before linearized reading' (duration: 406.873263ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:53.505763Z","caller":"traceutil/trace.go:171","msg":"trace[1345015680] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:655; }","duration":"406.932765ms","start":"2026-06-24T00:55:53.098825Z","end":"2026-06-24T00:55:53.505758Z","steps":["trace[1345015680] 'agreement among raft nodes before linearized reading' (duration: 406.878143ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:53.50578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:53.098798Z","time spent":"406.978556ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T00:55:53.505771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:53.098755Z","time spent":"407.008827ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T00:55:53.505874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.303847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-24T00:55:53.506027Z","caller":"traceutil/trace.go:171","msg":"trace[352671934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:655; }","duration":"406.152236ms","start":"2026-06-24T00:55:53.099745Z","end":"2026-06-24T00:55:53.505898Z","steps":["trace[352671934] 'agreement among raft nodes before linearized reading' (duration: 405.192793ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:53.506066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:55:53.099734Z","time spent":"406.323401ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-24T00:55:53.625955Z","caller":"traceutil/trace.go:171","msg":"trace[1115037013] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"115.356169ms","start":"2026-06-24T00:55:53.510576Z","end":"2026-06-24T00:55:53.625933Z","steps":["trace[1115037013] 'process raft request' (duration: 115.194235ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:53.626526Z","caller":"traceutil/trace.go:171","msg":"trace[1558506263] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"115.687497ms","start":"2026-06-24T00:55:53.510827Z","end":"2026-06-24T00:55:53.626496Z","steps":["trace[1558506263] 'process raft request' (duration: 115.491192ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:53.626909Z","caller":"traceutil/trace.go:171","msg":"trace[1279373135] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"115.538453ms","start":"2026-06-24T00:55:53.511341Z","end":"2026-06-24T00:55:53.626879Z","steps":["trace[1279373135] 'process raft request' (duration: 115.028691ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:53.626967Z","caller":"traceutil/trace.go:171","msg":"trace[300725272] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"115.536223ms","start":"2026-06-24T00:55:53.511411Z","end":"2026-06-24T00:55:53.626948Z","steps":["trace[300725272] 'process raft request' (duration: 115.038481ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:53.626299Z","caller":"traceutil/trace.go:171","msg":"trace[1423184015] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"115.634595ms","start":"2026-06-24T00:55:53.510649Z","end":"2026-06-24T00:55:53.626283Z","steps":["trace[1423184015] 'process raft request' (duration: 115.244706ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:53.626448Z","caller":"traceutil/trace.go:171","msg":"trace[1729717436] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"115.705047ms","start":"2026-06-24T00:55:53.510725Z","end":"2026-06-24T00:55:53.62643Z","steps":["trace[1729717436] 'process raft request' (duration: 115.311167ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:53.757304Z","caller":"traceutil/trace.go:171","msg":"trace[45757444] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"122.512719ms","start":"2026-06-24T00:55:53.63477Z","end":"2026-06-24T00:55:53.757283Z","steps":["trace[45757444] 'process raft request' (duration: 122.395756ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:53.762657Z","caller":"traceutil/trace.go:171","msg":"trace[334357824] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"126.514563ms","start":"2026-06-24T00:55:53.636127Z","end":"2026-06-24T00:55:53.762642Z","steps":["trace[334357824] 'process raft request' (duration: 126.36216ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:53.76377Z","caller":"traceutil/trace.go:171","msg":"trace[600611853] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"127.25985ms","start":"2026-06-24T00:55:53.63649Z","end":"2026-06-24T00:55:53.76375Z","steps":["trace[600611853] 'process raft request' (duration: 126.102943ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:53.763893Z","caller":"traceutil/trace.go:171","msg":"trace[713626306] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"122.089778ms","start":"2026-06-24T00:55:53.641781Z","end":"2026-06-24T00:55:53.763871Z","steps":["trace[713626306] 'process raft request' (duration: 121.698449ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:55.544503Z","caller":"traceutil/trace.go:171","msg":"trace[1034847629] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"119.246642ms","start":"2026-06-24T00:55:55.425219Z","end":"2026-06-24T00:55:55.544466Z","steps":["trace[1034847629] 'process raft request' (duration: 119.055038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:55:55.881599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.932306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T00:55:55.881748Z","caller":"traceutil/trace.go:171","msg":"trace[894325310] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:701; }","duration":"111.54895ms","start":"2026-06-24T00:55:55.770179Z","end":"2026-06-24T00:55:55.881728Z","steps":["trace[894325310] 'count revisions from in-memory index tree' (duration: 110.742481ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:55:55.892067Z","caller":"traceutil/trace.go:171","msg":"trace[1317231943] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"118.767991ms","start":"2026-06-24T00:55:55.773284Z","end":"2026-06-24T00:55:55.892052Z","steps":["trace[1317231943] 'process raft request' (duration: 118.465433ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:02.037869Z","caller":"traceutil/trace.go:171","msg":"trace[1285935089] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"197.029465ms","start":"2026-06-24T00:56:01.840817Z","end":"2026-06-24T00:56:02.037847Z","steps":["trace[1285935089] 'process raft request' (duration: 128.301885ms)","trace[1285935089] 'compare' (duration: 68.630718ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:56:02.045562Z","caller":"traceutil/trace.go:171","msg":"trace[1527014426] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"199.114525ms","start":"2026-06-24T00:56:01.846425Z","end":"2026-06-24T00:56:02.04554Z","steps":["trace[1527014426] 'process raft request' (duration: 198.968311ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:02.463789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.145805ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:56:02.463951Z","caller":"traceutil/trace.go:171","msg":"trace[1323020672] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"166.802323ms","start":"2026-06-24T00:56:02.297131Z","end":"2026-06-24T00:56:02.463934Z","steps":["trace[1323020672] 'process raft request' (duration: 48.448112ms)","trace[1323020672] 'compare' (duration: 118.007962ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:56:02.66634Z","caller":"traceutil/trace.go:171","msg":"trace[1386124463] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"192.269024ms","start":"2026-06-24T00:56:02.474052Z","end":"2026-06-24T00:56:02.666321Z","steps":["trace[1386124463] 'process raft request' (duration: 158.827335ms)","trace[1386124463] 'compare' (duration: 33.150602ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:56:02.769532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.227784ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-24T00:56:02.769821Z","caller":"traceutil/trace.go:171","msg":"trace[1724207847] linearizableReadLoop","detail":"{readStateIndex:790; appliedIndex:788; }","duration":"210.929083ms","start":"2026-06-24T00:56:02.558837Z","end":"2026-06-24T00:56:02.769766Z","steps":["trace[1724207847] 'read index received' (duration: 73.980234ms)","trace[1724207847] 'applied index is now lower than readState.Index' (duration: 136.944489ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:56:02.770012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.154019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:56:02.770063Z","caller":"traceutil/trace.go:171","msg":"trace[1794955848] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:758; }","duration":"211.255991ms","start":"2026-06-24T00:56:02.558792Z","end":"2026-06-24T00:56:02.770048Z","steps":["trace[1794955848] 'agreement among raft nodes before linearized reading' (duration: 211.112757ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:02.785973Z","caller":"traceutil/trace.go:171","msg":"trace[729009668] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"113.069236ms","start":"2026-06-24T00:56:02.672882Z","end":"2026-06-24T00:56:02.785951Z","steps":["trace[729009668] 'process raft request' (duration: 112.727697ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:04.883215Z","caller":"traceutil/trace.go:171","msg":"trace[2085003973] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"319.316749ms","start":"2026-06-24T00:56:04.563877Z","end":"2026-06-24T00:56:04.883194Z","steps":["trace[2085003973] 'process raft request' (duration: 319.189316ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:04.88336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:04.563852Z","time spent":"319.432692ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:56:05.968541Z","caller":"traceutil/trace.go:171","msg":"trace[1987940020] transaction","detail":"{read_only:false; response_revision:766; number_of_response:1; }","duration":"218.140153ms","start":"2026-06-24T00:56:05.750374Z","end":"2026-06-24T00:56:05.968514Z","steps":["trace[1987940020] 'process raft request' (duration: 212.579972ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:05.968597Z","caller":"traceutil/trace.go:171","msg":"trace[1251221283] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"216.604297ms","start":"2026-06-24T00:56:05.751963Z","end":"2026-06-24T00:56:05.968568Z","steps":["trace[1251221283] 'process raft request' (duration: 216.537886ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:05.968875Z","caller":"traceutil/trace.go:171","msg":"trace[826903956] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"217.035967ms","start":"2026-06-24T00:56:05.751777Z","end":"2026-06-24T00:56:05.968813Z","steps":["trace[826903956] 'process raft request' (duration: 216.525265ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:08.081296Z","caller":"traceutil/trace.go:171","msg":"trace[725748609] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"104.124505ms","start":"2026-06-24T00:56:07.977146Z","end":"2026-06-24T00:56:08.08127Z","steps":["trace[725748609] 'process raft request' (duration: 103.978412ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:08.125728Z","caller":"traceutil/trace.go:171","msg":"trace[1259174048] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"148.166713ms","start":"2026-06-24T00:56:07.977535Z","end":"2026-06-24T00:56:08.125702Z","steps":["trace[1259174048] 'process raft request' (duration: 148.004319ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:08.12613Z","caller":"traceutil/trace.go:171","msg":"trace[1735462250] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"147.647622ms","start":"2026-06-24T00:56:07.978423Z","end":"2026-06-24T00:56:08.126071Z","steps":["trace[1735462250] 'process raft request' (duration: 147.240012ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:10.668489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.813881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-24T00:56:10.66855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.914382ms","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-24T00:56:10.668615Z","caller":"traceutil/trace.go:171","msg":"trace[1283067522] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:790; }","duration":"839.981175ms","start":"2026-06-24T00:56:09.828611Z","end":"2026-06-24T00:56:10.668592Z","steps":["trace[1283067522] 'range keys from in-memory index tree' (duration: 839.629537ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:10.668624Z","caller":"traceutil/trace.go:171","msg":"trace[106220198] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:790; }","duration":"538.013695ms","start":"2026-06-24T00:56:10.130589Z","end":"2026-06-24T00:56:10.668602Z","steps":["trace[106220198] 'range keys from in-memory index tree' (duration: 537.773139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:10.668656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:09.828589Z","time spent":"840.057967ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T00:56:10.668664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:10.130583Z","time spent":"538.072747ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T00:56:10.668743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.21727ms","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-24T00:56:10.66878Z","caller":"traceutil/trace.go:171","msg":"trace[1704409881] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:790; }","duration":"538.285301ms","start":"2026-06-24T00:56:10.130482Z","end":"2026-06-24T00:56:10.668767Z","steps":["trace[1704409881] 'range keys from in-memory index tree' (duration: 538.025055ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:10.668757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.811894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-24T00:56:10.668806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:10.130463Z","time spent":"538.337233ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-24T00:56:10.668827Z","caller":"traceutil/trace.go:171","msg":"trace[427277680] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:790; }","duration":"784.920627ms","start":"2026-06-24T00:56:09.883889Z","end":"2026-06-24T00:56:10.66881Z","steps":["trace[427277680] 'count revisions from in-memory index tree' (duration: 784.673481ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:10.668845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.821682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-24T00:56:10.668878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:09.883873Z","time spent":"784.991209ms","remote":"127.0.0.1:51392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":74,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-06-24T00:56:10.668893Z","caller":"traceutil/trace.go:171","msg":"trace[1048071095] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:790; }","duration":"582.912014ms","start":"2026-06-24T00:56:10.085966Z","end":"2026-06-24T00:56:10.668878Z","steps":["trace[1048071095] 'range keys from in-memory index tree' (duration: 582.685509ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:10.668951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:10.085945Z","time spent":"582.975516ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T00:56:10.943864Z","caller":"traceutil/trace.go:171","msg":"trace[437222405] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:824; }","duration":"385.009868ms","start":"2026-06-24T00:56:10.558833Z","end":"2026-06-24T00:56:10.943842Z","steps":["trace[437222405] 'read index received' (duration: 384.804603ms)","trace[437222405] 'applied index is now lower than readState.Index' (duration: 204.425µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:56:10.943977Z","caller":"traceutil/trace.go:171","msg":"trace[27406157] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"482.20227ms","start":"2026-06-24T00:56:10.461746Z","end":"2026-06-24T00:56:10.943948Z","steps":["trace[27406157] 'process raft request' (duration: 481.958644ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:10.944044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.196282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T00:56:10.94411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:10.461725Z","time spent":"482.315192ms","remote":"127.0.0.1:51076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:56:10.944132Z","caller":"traceutil/trace.go:171","msg":"trace[1002978554] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:791; }","duration":"385.318035ms","start":"2026-06-24T00:56:10.558789Z","end":"2026-06-24T00:56:10.944107Z","steps":["trace[1002978554] 'agreement among raft nodes before linearized reading' (duration: 385.191272ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:10.944193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:10.558767Z","time spent":"385.415097ms","remote":"127.0.0.1:50830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T00:56:10.952997Z","caller":"traceutil/trace.go:171","msg":"trace[694560388] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"280.176255ms","start":"2026-06-24T00:56:10.672806Z","end":"2026-06-24T00:56:10.952982Z","steps":["trace[694560388] 'process raft request' (duration: 280.065403ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:10.953232Z","caller":"traceutil/trace.go:171","msg":"trace[486394635] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"280.260968ms","start":"2026-06-24T00:56:10.672953Z","end":"2026-06-24T00:56:10.953214Z","steps":["trace[486394635] 'process raft request' (duration: 280.004702ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:10.953432Z","caller":"traceutil/trace.go:171","msg":"trace[1499040019] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"279.543391ms","start":"2026-06-24T00:56:10.673876Z","end":"2026-06-24T00:56:10.95342Z","steps":["trace[1499040019] 'process raft request' (duration: 279.460819ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:10.953774Z","caller":"traceutil/trace.go:171","msg":"trace[229830569] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"280.140165ms","start":"2026-06-24T00:56:10.673249Z","end":"2026-06-24T00:56:10.953389Z","steps":["trace[229830569] 'process raft request' (duration: 279.885429ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:19.969316Z","caller":"traceutil/trace.go:171","msg":"trace[2007329900] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"161.891627ms","start":"2026-06-24T00:56:19.807403Z","end":"2026-06-24T00:56:19.969295Z","steps":["trace[2007329900] 'process raft request' (duration: 161.754294ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:22.102454Z","caller":"traceutil/trace.go:171","msg":"trace[332731184] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"128.50298ms","start":"2026-06-24T00:56:21.973925Z","end":"2026-06-24T00:56:22.102428Z","steps":["trace[332731184] 'process raft request' (duration: 58.630782ms)","trace[332731184] 'compare' (duration: 69.729544ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:56:22.728911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.128183ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-24T00:56:45.552877Z","caller":"traceutil/trace.go:171","msg":"trace[1027438100] linearizableReadLoop","detail":"{readStateIndex:1050; appliedIndex:1049; }","duration":"325.537185ms","start":"2026-06-24T00:56:45.227316Z","end":"2026-06-24T00:56:45.552853Z","steps":["trace[1027438100] 'read index received' (duration: 325.459244ms)","trace[1027438100] 'applied index is now lower than readState.Index' (duration: 77.201µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:56:45.552938Z","caller":"traceutil/trace.go:171","msg":"trace[1733392239] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"367.493335ms","start":"2026-06-24T00:56:45.185413Z","end":"2026-06-24T00:56:45.552906Z","steps":["trace[1733392239] 'process raft request' (duration: 367.29947ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:45.553067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:45.185386Z","time spent":"367.612208ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:56:45.553075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.589337ms","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-24T00:56:45.553076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.75154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-24T00:56:45.553108Z","caller":"traceutil/trace.go:171","msg":"trace[194270523] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1007; }","duration":"325.654698ms","start":"2026-06-24T00:56:45.227444Z","end":"2026-06-24T00:56:45.553099Z","steps":["trace[194270523] 'agreement among raft nodes before linearized reading' (duration: 325.550226ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:45.553114Z","caller":"traceutil/trace.go:171","msg":"trace[1521990709] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1007; }","duration":"325.852503ms","start":"2026-06-24T00:56:45.227251Z","end":"2026-06-24T00:56:45.553104Z","steps":["trace[1521990709] 'agreement among raft nodes before linearized reading' (duration: 325.733921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:45.553133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:45.227431Z","time spent":"325.696839ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T00:56:45.553144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:45.227226Z","time spent":"325.910304ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T00:56:45.553174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.693439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-06-24T00:56:45.553231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.093905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-24T00:56:45.553246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.940243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T00:56:45.55325Z","caller":"traceutil/trace.go:171","msg":"trace[89282624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1007; }","duration":"325.139397ms","start":"2026-06-24T00:56:45.228104Z","end":"2026-06-24T00:56:45.553244Z","steps":["trace[89282624] 'agreement among raft nodes before linearized reading' (duration: 325.091876ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:45.553251Z","caller":"traceutil/trace.go:171","msg":"trace[2034638489] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1007; }","duration":"322.804111ms","start":"2026-06-24T00:56:45.230426Z","end":"2026-06-24T00:56:45.55323Z","steps":["trace[2034638489] 'agreement among raft nodes before linearized reading' (duration: 322.588506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:45.553272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:45.228091Z","time spent":"325.177357ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-24T00:56:45.553274Z","caller":"traceutil/trace.go:171","msg":"trace[1491718622] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1007; }","duration":"302.993924ms","start":"2026-06-24T00:56:45.250271Z","end":"2026-06-24T00:56:45.553265Z","steps":["trace[1491718622] 'agreement among raft nodes before linearized reading' (duration: 302.947993ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:45.553302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:45.230416Z","time spent":"322.876993ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-24T00:56:45.553302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:45.250258Z","time spent":"303.037145ms","remote":"127.0.0.1:51352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":2,"response size":31,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"info","ts":"2026-06-24T00:56:45.669558Z","caller":"traceutil/trace.go:171","msg":"trace[292755032] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"110.949916ms","start":"2026-06-24T00:56:45.558574Z","end":"2026-06-24T00:56:45.669524Z","steps":["trace[292755032] 'process raft request' (duration: 69.348065ms)","trace[292755032] 'compare' (duration: 41.405877ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:56:45.669566Z","caller":"traceutil/trace.go:171","msg":"trace[388993564] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"110.327062ms","start":"2026-06-24T00:56:45.559211Z","end":"2026-06-24T00:56:45.669538Z","steps":["trace[388993564] 'process raft request' (duration: 110.23879ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:45.669835Z","caller":"traceutil/trace.go:171","msg":"trace[1079925577] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"110.078645ms","start":"2026-06-24T00:56:45.559737Z","end":"2026-06-24T00:56:45.669815Z","steps":["trace[1079925577] 'process raft request' (duration: 109.755118ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:47.750668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.348970495s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:56:47.750811Z","caller":"traceutil/trace.go:171","msg":"trace[1762044368] linearizableReadLoop","detail":"{readStateIndex:1055; appliedIndex:1054; }","duration":"334.172289ms","start":"2026-06-24T00:56:47.416616Z","end":"2026-06-24T00:56:47.750788Z","steps":["trace[1762044368] 'read index received' (duration: 41.821µs)","trace[1762044368] 'applied index is now lower than readState.Index' (duration: 334.128898ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:56:47.750896Z","caller":"traceutil/trace.go:171","msg":"trace[1765818545] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"1.560418631s","start":"2026-06-24T00:56:46.190462Z","end":"2026-06-24T00:56:47.750881Z","steps":["trace[1765818545] 'process raft request' (duration: 211.116198ms)","trace[1765818545] 'compare' (duration: 1.348578146s)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:56:47.750966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:46.190437Z","time spent":"1.560489032s","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:56:47.758125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.175892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.49\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-24T00:56:47.758277Z","caller":"traceutil/trace.go:171","msg":"trace[1764596781] range","detail":"{range_begin:/registry/masterleases/199.204.45.49; range_end:; response_count:1; response_revision:1012; }","duration":"341.687526ms","start":"2026-06-24T00:56:47.416567Z","end":"2026-06-24T00:56:47.758254Z","steps":["trace[1764596781] 'agreement among raft nodes before linearized reading' (duration: 334.615539ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:47.758349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:47.416545Z","time spent":"341.780568ms","remote":"127.0.0.1:50852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.49\" "} {"level":"warn","ts":"2026-06-24T00:56:47.824119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.843876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:56:47.824233Z","caller":"traceutil/trace.go:171","msg":"trace[571275068] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1013; }","duration":"296.01204ms","start":"2026-06-24T00:56:47.528194Z","end":"2026-06-24T00:56:47.824206Z","steps":["trace[571275068] 'agreement among raft nodes before linearized reading' (duration: 295.797085ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:47.82423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.430277ms","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-24T00:56:47.824311Z","caller":"traceutil/trace.go:171","msg":"trace[1707881338] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1013; }","duration":"150.55458ms","start":"2026-06-24T00:56:47.673735Z","end":"2026-06-24T00:56:47.824289Z","steps":["trace[1707881338] 'agreement among raft nodes before linearized reading' (duration: 150.293174ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:47.824395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.454627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-24T00:56:47.824464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.807138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-24T00:56:47.824491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.422081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-24T00:56:47.824499Z","caller":"traceutil/trace.go:171","msg":"trace[815358211] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1013; }","duration":"150.610771ms","start":"2026-06-24T00:56:47.673863Z","end":"2026-06-24T00:56:47.824474Z","steps":["trace[815358211] 'agreement among raft nodes before linearized reading' (duration: 150.207602ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:47.824522Z","caller":"traceutil/trace.go:171","msg":"trace[1411780241] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1013; }","duration":"151.515292ms","start":"2026-06-24T00:56:47.672998Z","end":"2026-06-24T00:56:47.824513Z","steps":["trace[1411780241] 'agreement among raft nodes before linearized reading' (duration: 151.42974ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:47.824527Z","caller":"traceutil/trace.go:171","msg":"trace[201554746] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1013; }","duration":"237.889649ms","start":"2026-06-24T00:56:47.586619Z","end":"2026-06-24T00:56:47.824509Z","steps":["trace[201554746] 'agreement among raft nodes before linearized reading' (duration: 237.715235ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:56:47.82461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.204087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-24T00:56:47.824646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.864398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:56:47.824672Z","caller":"traceutil/trace.go:171","msg":"trace[50805261] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1013; }","duration":"265.90166ms","start":"2026-06-24T00:56:47.558763Z","end":"2026-06-24T00:56:47.824664Z","steps":["trace[50805261] 'agreement among raft nodes before linearized reading' (duration: 265.863559ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:56:47.824675Z","caller":"traceutil/trace.go:171","msg":"trace[1549455477] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1013; }","duration":"266.296499ms","start":"2026-06-24T00:56:47.558362Z","end":"2026-06-24T00:56:47.824658Z","steps":["trace[1549455477] 'agreement among raft nodes before linearized reading' (duration: 266.084004ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:00.260776Z","caller":"traceutil/trace.go:171","msg":"trace[1758646834] linearizableReadLoop","detail":"{readStateIndex:1101; appliedIndex:1100; }","duration":"267.728723ms","start":"2026-06-24T00:56:59.993031Z","end":"2026-06-24T00:57:00.260759Z","steps":["trace[1758646834] 'read index received' (duration: 233.936466ms)","trace[1758646834] 'applied index is now lower than readState.Index' (duration: 33.788707ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:00.26079Z","caller":"traceutil/trace.go:171","msg":"trace[1213347046] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"309.771404ms","start":"2026-06-24T00:56:59.950998Z","end":"2026-06-24T00:57:00.260769Z","steps":["trace[1213347046] 'process raft request' (duration: 275.993458ms)","trace[1213347046] 'compare' (duration: 33.471319ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:00.260893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:56:59.950987Z","time spent":"309.847267ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:00.260924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.837717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-24T00:57:00.260926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.888947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T00:57:00.260949Z","caller":"traceutil/trace.go:171","msg":"trace[174546448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1055; }","duration":"245.887248ms","start":"2026-06-24T00:57:00.015055Z","end":"2026-06-24T00:57:00.260942Z","steps":["trace[174546448] 'agreement among raft nodes before linearized reading' (duration: 245.811467ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:00.26095Z","caller":"traceutil/trace.go:171","msg":"trace[1865339180] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1055; }","duration":"267.949098ms","start":"2026-06-24T00:56:59.992995Z","end":"2026-06-24T00:57:00.260944Z","steps":["trace[1865339180] 'agreement among raft nodes before linearized reading' (duration: 267.855096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:00.261044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.838275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-24T00:57:00.26112Z","caller":"traceutil/trace.go:171","msg":"trace[1151588131] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1055; }","duration":"236.938657ms","start":"2026-06-24T00:57:00.024165Z","end":"2026-06-24T00:57:00.261103Z","steps":["trace[1151588131] 'agreement among raft nodes before linearized reading' (duration: 236.726112ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:02.063416Z","caller":"traceutil/trace.go:171","msg":"trace[203000464] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"103.026299ms","start":"2026-06-24T00:57:01.96034Z","end":"2026-06-24T00:57:02.063366Z","steps":["trace[203000464] 'process raft request' (duration: 37.76458ms)","trace[203000464] 'compare' (duration: 65.154247ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:04.309837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.318536ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:57:04.309929Z","caller":"traceutil/trace.go:171","msg":"trace[671875683] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"241.010473ms","start":"2026-06-24T00:57:04.068896Z","end":"2026-06-24T00:57:04.309906Z","steps":["trace[671875683] 'process raft request' (duration: 59.549314ms)","trace[671875683] 'compare' (duration: 180.871835ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:04.309541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.909511ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:04.310316Z","caller":"traceutil/trace.go:171","msg":"trace[491109418] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1066; }","duration":"199.688429ms","start":"2026-06-24T00:57:04.110602Z","end":"2026-06-24T00:57:04.31029Z","steps":["trace[491109418] 'range keys from in-memory index tree' (duration: 198.893291ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:04.4876Z","caller":"traceutil/trace.go:171","msg":"trace[1247462263] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"123.639325ms","start":"2026-06-24T00:57:04.36393Z","end":"2026-06-24T00:57:04.487569Z","steps":["trace[1247462263] 'process raft request' (duration: 109.563144ms)","trace[1247462263] 'compare' (duration: 13.961439ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:10.606137Z","caller":"traceutil/trace.go:171","msg":"trace[982171969] linearizableReadLoop","detail":"{readStateIndex:1134; appliedIndex:1133; }","duration":"241.530936ms","start":"2026-06-24T00:57:10.364582Z","end":"2026-06-24T00:57:10.606113Z","steps":["trace[982171969] 'read index received' (duration: 241.477675ms)","trace[982171969] 'applied index is now lower than readState.Index' (duration: 52.231µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:10.606501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.896835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T00:57:10.606571Z","caller":"traceutil/trace.go:171","msg":"trace[1465498929] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1086; }","duration":"242.030278ms","start":"2026-06-24T00:57:10.364528Z","end":"2026-06-24T00:57:10.606558Z","steps":["trace[1465498929] 'agreement among raft nodes before linearized reading' (duration: 241.72315ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:10.606225Z","caller":"traceutil/trace.go:171","msg":"trace[77530283] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"555.249014ms","start":"2026-06-24T00:57:10.050924Z","end":"2026-06-24T00:57:10.606174Z","steps":["trace[77530283] 'process raft request' (duration: 555.048209ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:10.607544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:10.050902Z","time spent":"556.262507ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:57:10.777092Z","caller":"traceutil/trace.go:171","msg":"trace[1214451422] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"166.145709ms","start":"2026-06-24T00:57:10.610913Z","end":"2026-06-24T00:57:10.777059Z","steps":["trace[1214451422] 'process raft request' (duration: 119.114579ms)","trace[1214451422] 'compare' (duration: 46.701732ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:10.7779Z","caller":"traceutil/trace.go:171","msg":"trace[1500447919] linearizableReadLoop","detail":"{readStateIndex:1139; appliedIndex:1135; }","duration":"112.525393ms","start":"2026-06-24T00:57:10.665362Z","end":"2026-06-24T00:57:10.777887Z","steps":["trace[1500447919] 'read index received' (duration: 13.199661ms)","trace[1500447919] 'applied index is now lower than readState.Index' (duration: 99.324522ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:10.778067Z","caller":"traceutil/trace.go:171","msg":"trace[184979565] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"166.591588ms","start":"2026-06-24T00:57:10.611433Z","end":"2026-06-24T00:57:10.778025Z","steps":["trace[184979565] 'process raft request' (duration: 166.372633ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:10.778188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.769839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:10.778255Z","caller":"traceutil/trace.go:171","msg":"trace[190525216] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1091; }","duration":"112.898722ms","start":"2026-06-24T00:57:10.665342Z","end":"2026-06-24T00:57:10.778241Z","steps":["trace[190525216] 'agreement among raft nodes before linearized reading' (duration: 112.746799ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:10.778071Z","caller":"traceutil/trace.go:171","msg":"trace[392683782] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"166.540637ms","start":"2026-06-24T00:57:10.611432Z","end":"2026-06-24T00:57:10.777973Z","steps":["trace[392683782] 'process raft request' (duration: 166.170328ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:10.778878Z","caller":"traceutil/trace.go:171","msg":"trace[251556281] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"166.378124ms","start":"2026-06-24T00:57:10.611333Z","end":"2026-06-24T00:57:10.777711Z","steps":["trace[251556281] 'process raft request' (duration: 165.641797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:11.909908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.146701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:11.910317Z","caller":"traceutil/trace.go:171","msg":"trace[1592770758] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1091; }","duration":"351.387967ms","start":"2026-06-24T00:57:11.55868Z","end":"2026-06-24T00:57:11.910068Z","steps":["trace[1592770758] 'range keys from in-memory index tree' (duration: 351.066788ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:11.910393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:11.558661Z","time spent":"351.715864ms","remote":"127.0.0.1:50830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T00:57:13.020523Z","caller":"traceutil/trace.go:171","msg":"trace[1610615026] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"233.745892ms","start":"2026-06-24T00:57:12.786753Z","end":"2026-06-24T00:57:13.020499Z","steps":["trace[1610615026] 'process raft request' (duration: 233.700051ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:13.020618Z","caller":"traceutil/trace.go:171","msg":"trace[215671150] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"235.002691ms","start":"2026-06-24T00:57:12.785587Z","end":"2026-06-24T00:57:13.02059Z","steps":["trace[215671150] 'process raft request' (duration: 175.482068ms)","trace[215671150] 'compare' (duration: 58.95321ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:13.020847Z","caller":"traceutil/trace.go:171","msg":"trace[204227424] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"234.894239ms","start":"2026-06-24T00:57:12.785896Z","end":"2026-06-24T00:57:13.020791Z","steps":["trace[204227424] 'process raft request' (duration: 234.460339ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:14.884323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.706747ms","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-24T00:57:14.884413Z","caller":"traceutil/trace.go:171","msg":"trace[1626156266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1099; }","duration":"165.83192ms","start":"2026-06-24T00:57:14.718558Z","end":"2026-06-24T00:57:14.88439Z","steps":["trace[1626156266] 'range keys from in-memory index tree' (duration: 165.579464ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:15.634761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.082669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T00:57:15.634864Z","caller":"traceutil/trace.go:171","msg":"trace[1734310584] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1104; }","duration":"245.231123ms","start":"2026-06-24T00:57:15.389605Z","end":"2026-06-24T00:57:15.634837Z","steps":["trace[1734310584] 'count revisions from in-memory index tree' (duration: 244.975207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:15.635042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.907454ms","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-24T00:57:15.635157Z","caller":"traceutil/trace.go:171","msg":"trace[1356251619] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1104; }","duration":"398.425155ms","start":"2026-06-24T00:57:15.236712Z","end":"2026-06-24T00:57:15.635137Z","steps":["trace[1356251619] 'count revisions from in-memory index tree' (duration: 397.77327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:15.635339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:15.236692Z","time spent":"398.63234ms","remote":"127.0.0.1:51276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-06-24T00:57:17.1689Z","caller":"traceutil/trace.go:171","msg":"trace[1005748447] linearizableReadLoop","detail":"{readStateIndex:1155; appliedIndex:1154; }","duration":"226.334038ms","start":"2026-06-24T00:57:16.942545Z","end":"2026-06-24T00:57:17.168879Z","steps":["trace[1005748447] 'read index received' (duration: 226.179454ms)","trace[1005748447] 'applied index is now lower than readState.Index' (duration: 153.784µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:17.168957Z","caller":"traceutil/trace.go:171","msg":"trace[729767963] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"239.905718ms","start":"2026-06-24T00:57:16.92902Z","end":"2026-06-24T00:57:17.168926Z","steps":["trace[729767963] 'process raft request' (duration: 239.745084ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:17.169317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.586807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-24T00:57:17.169353Z","caller":"traceutil/trace.go:171","msg":"trace[1104013209] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1106; }","duration":"118.653799ms","start":"2026-06-24T00:57:17.050689Z","end":"2026-06-24T00:57:17.169343Z","steps":["trace[1104013209] 'agreement among raft nodes before linearized reading' (duration: 118.563327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:17.16951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.476993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-24T00:57:17.169113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.555663ms","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-24T00:57:17.16962Z","caller":"traceutil/trace.go:171","msg":"trace[711353206] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1106; }","duration":"101.613517ms","start":"2026-06-24T00:57:17.067986Z","end":"2026-06-24T00:57:17.1696Z","steps":["trace[711353206] 'agreement among raft nodes before linearized reading' (duration: 101.384631ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:17.16964Z","caller":"traceutil/trace.go:171","msg":"trace[674041857] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1106; }","duration":"227.135216ms","start":"2026-06-24T00:57:16.942494Z","end":"2026-06-24T00:57:17.169629Z","steps":["trace[674041857] 'agreement among raft nodes before linearized reading' (duration: 226.507102ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:17.169781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.693682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-24T00:57:17.169981Z","caller":"traceutil/trace.go:171","msg":"trace[2015984595] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1106; }","duration":"102.902567ms","start":"2026-06-24T00:57:17.06701Z","end":"2026-06-24T00:57:17.169836Z","steps":["trace[2015984595] 'agreement among raft nodes before linearized reading' (duration: 102.515268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:17.399869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.161877ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:57:17.399963Z","caller":"traceutil/trace.go:171","msg":"trace[555627339] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"225.59502ms","start":"2026-06-24T00:57:17.17435Z","end":"2026-06-24T00:57:17.399945Z","steps":["trace[555627339] 'process raft request' (duration: 48.282539ms)","trace[555627339] 'compare' (duration: 177.081036ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:17.472778Z","caller":"traceutil/trace.go:171","msg":"trace[1789079161] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"297.546486ms","start":"2026-06-24T00:57:17.175208Z","end":"2026-06-24T00:57:17.472755Z","steps":["trace[1789079161] 'process raft request' (duration: 297.475995ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:17.472782Z","caller":"traceutil/trace.go:171","msg":"trace[1241784735] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"297.580657ms","start":"2026-06-24T00:57:17.17517Z","end":"2026-06-24T00:57:17.47275Z","steps":["trace[1241784735] 'process raft request' (duration: 297.387663ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:17.473008Z","caller":"traceutil/trace.go:171","msg":"trace[852411829] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"296.171514ms","start":"2026-06-24T00:57:17.176824Z","end":"2026-06-24T00:57:17.472995Z","steps":["trace[852411829] 'process raft request' (duration: 295.897097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:33.676062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.211084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:33.676145Z","caller":"traceutil/trace.go:171","msg":"trace[630122811] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1210; }","duration":"117.353258ms","start":"2026-06-24T00:57:33.558775Z","end":"2026-06-24T00:57:33.676129Z","steps":["trace[630122811] 'range keys from in-memory index tree' (duration: 117.090962ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:33.676279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.081913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T00:57:33.676361Z","caller":"traceutil/trace.go:171","msg":"trace[1647622657] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1210; }","duration":"299.209586ms","start":"2026-06-24T00:57:33.377132Z","end":"2026-06-24T00:57:33.676342Z","steps":["trace[1647622657] 'range keys from in-memory index tree' (duration: 298.845547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:33.676352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.319422ms","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-24T00:57:33.676418Z","caller":"traceutil/trace.go:171","msg":"trace[1470523724] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1210; }","duration":"194.421975ms","start":"2026-06-24T00:57:33.481979Z","end":"2026-06-24T00:57:33.676401Z","steps":["trace[1470523724] 'range keys from in-memory index tree' (duration: 194.154989ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:33.676436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.954168ms","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-24T00:57:33.676524Z","caller":"traceutil/trace.go:171","msg":"trace[2129125331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1210; }","duration":"103.05853ms","start":"2026-06-24T00:57:33.573435Z","end":"2026-06-24T00:57:33.676494Z","steps":["trace[2129125331] 'range keys from in-memory index tree' (duration: 102.770443ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:35.466156Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256279706445091734,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:57:35.966565Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256279706445091734,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T00:57:36.191503Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.229654638s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T00:57:36.191785Z","caller":"traceutil/trace.go:171","msg":"trace[1492161509] linearizableReadLoop","detail":"{readStateIndex:1271; appliedIndex:1270; }","duration":"1.226032382s","start":"2026-06-24T00:57:34.965735Z","end":"2026-06-24T00:57:36.191768Z","steps":["trace[1492161509] 'read index received' (duration: 1.225887859s)","trace[1492161509] 'applied index is now lower than readState.Index' (duration: 143.923µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:36.191853Z","caller":"traceutil/trace.go:171","msg":"trace[2065588493] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"1.230098878s","start":"2026-06-24T00:57:34.961744Z","end":"2026-06-24T00:57:36.191843Z","steps":["trace[2065588493] 'process raft request' (duration: 1.229918063s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:36.191945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:34.961721Z","time spent":"1.230161359s","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:36.192324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.028553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T00:57:36.192365Z","caller":"traceutil/trace.go:171","msg":"trace[234525661] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1216; }","duration":"450.085674ms","start":"2026-06-24T00:57:35.742269Z","end":"2026-06-24T00:57:36.192355Z","steps":["trace[234525661] 'agreement among raft nodes before linearized reading' (duration: 449.974331ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:36.1924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:35.742262Z","time spent":"450.124765ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-24T00:57:36.192553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.22681944s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:36.19259Z","caller":"traceutil/trace.go:171","msg":"trace[2081029129] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1216; }","duration":"1.226898122s","start":"2026-06-24T00:57:34.965681Z","end":"2026-06-24T00:57:36.192579Z","steps":["trace[2081029129] 'agreement among raft nodes before linearized reading' (duration: 1.226841631s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:36.19262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:34.96566Z","time spent":"1.226949483s","remote":"127.0.0.1:45566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-24T00:57:36.192815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.479893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T00:57:36.192851Z","caller":"traceutil/trace.go:171","msg":"trace[1478086478] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1216; }","duration":"450.537924ms","start":"2026-06-24T00:57:35.742305Z","end":"2026-06-24T00:57:36.192843Z","steps":["trace[1478086478] 'agreement among raft nodes before linearized reading' (duration: 450.446472ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:36.192878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:35.742298Z","time spent":"450.572735ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T00:57:36.193107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.042296ms","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-24T00:57:36.193149Z","caller":"traceutil/trace.go:171","msg":"trace[1079278461] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1216; }","duration":"451.126118ms","start":"2026-06-24T00:57:35.742013Z","end":"2026-06-24T00:57:36.193139Z","steps":["trace[1079278461] 'agreement among raft nodes before linearized reading' (duration: 451.021376ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:36.193156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.797289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-24T00:57:36.193179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:35.741991Z","time spent":"451.18016ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-24T00:57:36.193186Z","caller":"traceutil/trace.go:171","msg":"trace[1895200244] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1216; }","duration":"455.852549ms","start":"2026-06-24T00:57:35.737325Z","end":"2026-06-24T00:57:36.193177Z","steps":["trace[1895200244] 'agreement among raft nodes before linearized reading' (duration: 455.765497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:36.193197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.068227ms","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-24T00:57:36.193207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:35.73731Z","time spent":"455.892701ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-24T00:57:36.193227Z","caller":"traceutil/trace.go:171","msg":"trace[1488070837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1216; }","duration":"451.137488ms","start":"2026-06-24T00:57:35.742081Z","end":"2026-06-24T00:57:36.193218Z","steps":["trace[1488070837] 'agreement among raft nodes before linearized reading' (duration: 451.056356ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:36.193252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:35.742061Z","time spent":"451.18355ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T00:57:36.192051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.288254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:36.19352Z","caller":"traceutil/trace.go:171","msg":"trace[962711254] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1216; }","duration":"634.779559ms","start":"2026-06-24T00:57:35.558731Z","end":"2026-06-24T00:57:36.19351Z","steps":["trace[962711254] 'agreement among raft nodes before linearized reading' (duration: 633.295254ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:36.193542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:35.558719Z","time spent":"634.81671ms","remote":"127.0.0.1:50830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T00:57:46.621218Z","caller":"traceutil/trace.go:171","msg":"trace[988023039] linearizableReadLoop","detail":"{readStateIndex:1306; appliedIndex:1305; }","duration":"353.100827ms","start":"2026-06-24T00:57:46.268098Z","end":"2026-06-24T00:57:46.621199Z","steps":["trace[988023039] 'read index received' (duration: 352.947934ms)","trace[988023039] 'applied index is now lower than readState.Index' (duration: 151.893µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:46.621327Z","caller":"traceutil/trace.go:171","msg":"trace[1409476391] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"398.489508ms","start":"2026-06-24T00:57:46.222808Z","end":"2026-06-24T00:57:46.621298Z","steps":["trace[1409476391] 'process raft request' (duration: 398.250902ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:46.621433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.492151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-24T00:57:46.621459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:46.222783Z","time spent":"398.60485ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:57:46.62147Z","caller":"traceutil/trace.go:171","msg":"trace[399632422] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1249; }","duration":"268.571503ms","start":"2026-06-24T00:57:46.352889Z","end":"2026-06-24T00:57:46.621461Z","steps":["trace[399632422] 'agreement among raft nodes before linearized reading' (duration: 268.44205ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:46.621474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.367463ms","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-24T00:57:46.621531Z","caller":"traceutil/trace.go:171","msg":"trace[2094961538] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1249; }","duration":"353.454275ms","start":"2026-06-24T00:57:46.268061Z","end":"2026-06-24T00:57:46.621515Z","steps":["trace[2094961538] 'agreement among raft nodes before linearized reading' (duration: 353.25826ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:46.62153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.469541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-24T00:57:46.621568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:46.268044Z","time spent":"353.516277ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T00:57:46.621593Z","caller":"traceutil/trace.go:171","msg":"trace[1960820591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1249; }","duration":"257.586904ms","start":"2026-06-24T00:57:46.363988Z","end":"2026-06-24T00:57:46.621575Z","steps":["trace[1960820591] 'agreement among raft nodes before linearized reading' (duration: 257.39502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:46.621604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.627566ms","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-24T00:57:46.621639Z","caller":"traceutil/trace.go:171","msg":"trace[1477960498] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1249; }","duration":"257.707627ms","start":"2026-06-24T00:57:46.363922Z","end":"2026-06-24T00:57:46.62163Z","steps":["trace[1477960498] 'agreement among raft nodes before linearized reading' (duration: 257.629146ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:46.621767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.072828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T00:57:46.621836Z","caller":"traceutil/trace.go:171","msg":"trace[2073472750] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1249; }","duration":"256.170901ms","start":"2026-06-24T00:57:46.365658Z","end":"2026-06-24T00:57:46.621829Z","steps":["trace[2073472750] 'agreement among raft nodes before linearized reading' (duration: 256.059638ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:48.962224Z","caller":"traceutil/trace.go:171","msg":"trace[635661922] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"314.202069ms","start":"2026-06-24T00:57:48.647989Z","end":"2026-06-24T00:57:48.962191Z","steps":["trace[635661922] 'process raft request' (duration: 313.876121ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:48.962388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:48.647977Z","time spent":"314.321673ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:57:48.962515Z","caller":"traceutil/trace.go:171","msg":"trace[510605257] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"314.354083ms","start":"2026-06-24T00:57:48.648031Z","end":"2026-06-24T00:57:48.962385Z","steps":["trace[510605257] 'process raft request' (duration: 314.001304ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:48.962653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:48.647996Z","time spent":"314.584938ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:57:48.962639Z","caller":"traceutil/trace.go:171","msg":"trace[1904972225] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"314.768752ms","start":"2026-06-24T00:57:48.647853Z","end":"2026-06-24T00:57:48.962622Z","steps":["trace[1904972225] 'process raft request' (duration: 314.436874ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:48.96274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:48.647819Z","time spent":"314.876645ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:57:48.962832Z","caller":"traceutil/trace.go:171","msg":"trace[517856203] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"313.942633ms","start":"2026-06-24T00:57:48.648878Z","end":"2026-06-24T00:57:48.962821Z","steps":["trace[517856203] 'process raft request' (duration: 313.474982ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:48.962894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:48.648867Z","time spent":"313.995945ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:52.896341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.097907ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-24T00:57:52.896664Z","caller":"traceutil/trace.go:171","msg":"trace[860167471] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"215.447041ms","start":"2026-06-24T00:57:52.681139Z","end":"2026-06-24T00:57:52.896586Z","steps":["trace[860167471] 'process raft request' (duration: 215.308628ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:55.000185Z","caller":"traceutil/trace.go:171","msg":"trace[356581411] linearizableReadLoop","detail":"{readStateIndex:1344; appliedIndex:1343; }","duration":"100.002608ms","start":"2026-06-24T00:57:54.900142Z","end":"2026-06-24T00:57:55.000144Z","steps":["trace[356581411] 'read index received' (duration: 99.65022ms)","trace[356581411] 'applied index is now lower than readState.Index' (duration: 350.768µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:55.000836Z","caller":"traceutil/trace.go:171","msg":"trace[1286419097] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"320.526819ms","start":"2026-06-24T00:57:54.680283Z","end":"2026-06-24T00:57:55.00081Z","steps":["trace[1286419097] 'process raft request' (duration: 319.606987ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:55.001277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:54.680258Z","time spent":"320.634122ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:55.002397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.248461ms","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-24T00:57:55.002637Z","caller":"traceutil/trace.go:171","msg":"trace[313309068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1285; }","duration":"102.314202ms","start":"2026-06-24T00:57:54.900131Z","end":"2026-06-24T00:57:55.002445Z","steps":["trace[313309068] 'agreement among raft nodes before linearized reading' (duration: 102.114738ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:55.521984Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17256279706445091896,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T00:57:55.723614Z","caller":"traceutil/trace.go:171","msg":"trace[1401473972] linearizableReadLoop","detail":"{readStateIndex:1345; appliedIndex:1344; }","duration":"702.440714ms","start":"2026-06-24T00:57:55.021151Z","end":"2026-06-24T00:57:55.723592Z","steps":["trace[1401473972] 'read index received' (duration: 695.948541ms)","trace[1401473972] 'applied index is now lower than readState.Index' (duration: 6.490663ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:55.723763Z","caller":"traceutil/trace.go:171","msg":"trace[1082900725] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"711.780694ms","start":"2026-06-24T00:57:55.011968Z","end":"2026-06-24T00:57:55.723749Z","steps":["trace[1082900725] 'process raft request' (duration: 705.171568ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:55.724275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.000803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"warn","ts":"2026-06-24T00:57:55.724286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.644998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-24T00:57:55.72431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"680.494146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:128716"} {"level":"info","ts":"2026-06-24T00:57:55.724334Z","caller":"traceutil/trace.go:171","msg":"trace[1868762490] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1286; }","duration":"685.125355ms","start":"2026-06-24T00:57:55.039196Z","end":"2026-06-24T00:57:55.724321Z","steps":["trace[1868762490] 'agreement among raft nodes before linearized reading' (duration: 684.959921ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:55.72434Z","caller":"traceutil/trace.go:171","msg":"trace[1198791303] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1286; }","duration":"680.548218ms","start":"2026-06-24T00:57:55.043784Z","end":"2026-06-24T00:57:55.724332Z","steps":["trace[1198791303] 'agreement among raft nodes before linearized reading' (duration: 680.413744ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:55.724335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.653378ms","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-24T00:57:55.72434Z","caller":"traceutil/trace.go:171","msg":"trace[918153693] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1286; }","duration":"649.753391ms","start":"2026-06-24T00:57:55.074574Z","end":"2026-06-24T00:57:55.724328Z","steps":["trace[918153693] 'agreement among raft nodes before linearized reading' (duration: 649.590478ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:55.724364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:55.039164Z","time spent":"685.193807ms","remote":"127.0.0.1:50880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":142,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"warn","ts":"2026-06-24T00:57:55.724367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:55.043772Z","time spent":"680.587398ms","remote":"127.0.0.1:50870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":128740,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-06-24T00:57:55.724381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:55.074544Z","time spent":"649.830613ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-24T00:57:55.72438Z","caller":"traceutil/trace.go:171","msg":"trace[1985172872] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1286; }","duration":"649.71644ms","start":"2026-06-24T00:57:55.074651Z","end":"2026-06-24T00:57:55.724368Z","steps":["trace[1985172872] 'agreement among raft nodes before linearized reading' (duration: 649.599248ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:55.724345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.618151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-24T00:57:55.724426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:55.074646Z","time spent":"649.770072ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-24T00:57:55.724455Z","caller":"traceutil/trace.go:171","msg":"trace[900769748] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1286; }","duration":"650.770995ms","start":"2026-06-24T00:57:55.07365Z","end":"2026-06-24T00:57:55.724421Z","steps":["trace[900769748] 'agreement among raft nodes before linearized reading' (duration: 650.528219ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:55.72452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:55.073627Z","time spent":"650.883118ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-24T00:57:55.723915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.755411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T00:57:55.724601Z","caller":"traceutil/trace.go:171","msg":"trace[1900399673] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1286; }","duration":"703.498499ms","start":"2026-06-24T00:57:55.021092Z","end":"2026-06-24T00:57:55.724591Z","steps":["trace[1900399673] 'agreement among raft nodes before linearized reading' (duration: 702.7037ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:55.724632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:55.020885Z","time spent":"703.738504ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T00:57:55.724238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.292214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:55.724687Z","caller":"traceutil/trace.go:171","msg":"trace[1147506904] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1286; }","duration":"164.803167ms","start":"2026-06-24T00:57:55.559876Z","end":"2026-06-24T00:57:55.724679Z","steps":["trace[1147506904] 'agreement among raft nodes before linearized reading' (duration: 164.330616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:55.724782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:55.011946Z","time spent":"712.351208ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:56.246749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.596912ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:57:56.247025Z","caller":"traceutil/trace.go:171","msg":"trace[1937380364] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"517.42922ms","start":"2026-06-24T00:57:55.729578Z","end":"2026-06-24T00:57:56.247007Z","steps":["trace[1937380364] 'process raft request' (duration: 131.48751ms)","trace[1937380364] 'compare' (duration: 384.989118ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:56.247107Z","caller":"traceutil/trace.go:171","msg":"trace[1112213415] linearizableReadLoop","detail":"{readStateIndex:1346; appliedIndex:1345; }","duration":"517.475481ms","start":"2026-06-24T00:57:55.729599Z","end":"2026-06-24T00:57:56.247074Z","steps":["trace[1112213415] 'read index received' (duration: 155.783µs)","trace[1112213415] 'applied index is now lower than readState.Index' (duration: 517.316528ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:56.247148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:55.72956Z","time spent":"517.526142ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:56.247236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.635636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-06-24T00:57:56.247295Z","caller":"traceutil/trace.go:171","msg":"trace[513525011] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1287; }","duration":"517.714187ms","start":"2026-06-24T00:57:55.729573Z","end":"2026-06-24T00:57:56.247287Z","steps":["trace[513525011] 'agreement among raft nodes before linearized reading' (duration: 517.627285ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:56.247319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:55.729561Z","time spent":"517.750698ms","remote":"127.0.0.1:50880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":142,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"warn","ts":"2026-06-24T00:57:56.247857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.043078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:56.247888Z","caller":"traceutil/trace.go:171","msg":"trace[455872207] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1290; }","duration":"111.1159ms","start":"2026-06-24T00:57:56.136764Z","end":"2026-06-24T00:57:56.24788Z","steps":["trace[455872207] 'agreement among raft nodes before linearized reading' (duration: 111.027718ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:56.248049Z","caller":"traceutil/trace.go:171","msg":"trace[80439397] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"518.288261ms","start":"2026-06-24T00:57:55.729753Z","end":"2026-06-24T00:57:56.248041Z","steps":["trace[80439397] 'process raft request' (duration: 517.965063ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:56.248097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:55.729745Z","time spent":"518.326302ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:57:56.248208Z","caller":"traceutil/trace.go:171","msg":"trace[906065069] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"517.873551ms","start":"2026-06-24T00:57:55.730303Z","end":"2026-06-24T00:57:56.248177Z","steps":["trace[906065069] 'process raft request' (duration: 517.461711ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:56.248032Z","caller":"traceutil/trace.go:171","msg":"trace[565041840] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"518.304131ms","start":"2026-06-24T00:57:55.729688Z","end":"2026-06-24T00:57:56.247992Z","steps":["trace[565041840] 'process raft request' (duration: 517.986643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:56.24843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:55.729676Z","time spent":"518.698131ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:56.248526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:55.730289Z","time spent":"517.947102ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:57:56.819116Z","caller":"traceutil/trace.go:171","msg":"trace[795335158] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"147.633362ms","start":"2026-06-24T00:57:56.671461Z","end":"2026-06-24T00:57:56.819095Z","steps":["trace[795335158] 'process raft request' (duration: 147.503098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:57.687994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.202557ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T00:57:57.688098Z","caller":"traceutil/trace.go:171","msg":"trace[99394496] linearizableReadLoop","detail":"{readStateIndex:1353; appliedIndex:1352; }","duration":"337.225652ms","start":"2026-06-24T00:57:57.350858Z","end":"2026-06-24T00:57:57.688083Z","steps":["trace[99394496] 'read index received' (duration: 52.111µs)","trace[99394496] 'applied index is now lower than readState.Index' (duration: 337.172251ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:57.68812Z","caller":"traceutil/trace.go:171","msg":"trace[1978375534] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"672.531579ms","start":"2026-06-24T00:57:57.015557Z","end":"2026-06-24T00:57:57.688088Z","steps":["trace[1978375534] 'process raft request' (duration: 208.139468ms)","trace[1978375534] 'compare' (duration: 463.89912ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:57:57.688223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.369935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5330"} {"level":"info","ts":"2026-06-24T00:57:57.688248Z","caller":"traceutil/trace.go:171","msg":"trace[915538702] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1294; }","duration":"337.395546ms","start":"2026-06-24T00:57:57.350844Z","end":"2026-06-24T00:57:57.68824Z","steps":["trace[915538702] 'agreement among raft nodes before linearized reading' (duration: 337.301763ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:57.688266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:57.350791Z","time spent":"337.471147ms","remote":"127.0.0.1:50998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":5354,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-24T00:57:57.688271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:57.015539Z","time spent":"672.653542ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:57:57.688305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.956758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:57:57.688335Z","caller":"traceutil/trace.go:171","msg":"trace[1762669747] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1294; }","duration":"131.006209ms","start":"2026-06-24T00:57:57.55732Z","end":"2026-06-24T00:57:57.688326Z","steps":["trace[1762669747] 'agreement among raft nodes before linearized reading' (duration: 130.955908ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:57.688354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.042961ms","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-24T00:57:57.688439Z","caller":"traceutil/trace.go:171","msg":"trace[1187177708] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1294; }","duration":"148.164844ms","start":"2026-06-24T00:57:57.540254Z","end":"2026-06-24T00:57:57.688419Z","steps":["trace[1187177708] 'agreement among raft nodes before linearized reading' (duration: 148.039321ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:57.688886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.360055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.49\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-24T00:57:57.688939Z","caller":"traceutil/trace.go:171","msg":"trace[1579317042] range","detail":"{range_begin:/registry/masterleases/199.204.45.49; range_end:; response_count:1; response_revision:1294; }","duration":"267.448857ms","start":"2026-06-24T00:57:57.421476Z","end":"2026-06-24T00:57:57.688925Z","steps":["trace[1579317042] 'agreement among raft nodes before linearized reading' (duration: 266.775851ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:57.826683Z","caller":"traceutil/trace.go:171","msg":"trace[627664326] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"130.124879ms","start":"2026-06-24T00:57:57.696537Z","end":"2026-06-24T00:57:57.826662Z","steps":["trace[627664326] 'process raft request' (duration: 97.004338ms)","trace[627664326] 'compare' (duration: 33.012108ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:57.837353Z","caller":"traceutil/trace.go:171","msg":"trace[1458168360] linearizableReadLoop","detail":"{readStateIndex:1356; appliedIndex:1354; }","duration":"107.180538ms","start":"2026-06-24T00:57:57.730161Z","end":"2026-06-24T00:57:57.837341Z","steps":["trace[1458168360] 'read index received' (duration: 63.392095ms)","trace[1458168360] 'applied index is now lower than readState.Index' (duration: 43.787693ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:57:57.837424Z","caller":"traceutil/trace.go:171","msg":"trace[524811515] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"119.256542ms","start":"2026-06-24T00:57:57.718161Z","end":"2026-06-24T00:57:57.837417Z","steps":["trace[524811515] 'process raft request' (duration: 119.099119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:57.837668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.496795ms","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-24T00:57:57.837762Z","caller":"traceutil/trace.go:171","msg":"trace[1217774565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1296; }","duration":"107.636918ms","start":"2026-06-24T00:57:57.730112Z","end":"2026-06-24T00:57:57.837749Z","steps":["trace[1217774565] 'agreement among raft nodes before linearized reading' (duration: 107.400613ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:58.391044Z","caller":"traceutil/trace.go:171","msg":"trace[1721752689] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"136.041148ms","start":"2026-06-24T00:57:58.254978Z","end":"2026-06-24T00:57:58.391019Z","steps":["trace[1721752689] 'process raft request' (duration: 135.856894ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:57:58.579723Z","caller":"traceutil/trace.go:171","msg":"trace[417611766] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"323.153861ms","start":"2026-06-24T00:57:58.25655Z","end":"2026-06-24T00:57:58.579704Z","steps":["trace[417611766] 'process raft request' (duration: 323.084489ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:58.579857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:58.256544Z","time spent":"323.241123ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:57:58.580003Z","caller":"traceutil/trace.go:171","msg":"trace[1174067645] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"323.485368ms","start":"2026-06-24T00:57:58.256485Z","end":"2026-06-24T00:57:58.579971Z","steps":["trace[1174067645] 'process raft request' (duration: 322.205598ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:58.580178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:58.256473Z","time spent":"323.604322ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:57:58.581313Z","caller":"traceutil/trace.go:171","msg":"trace[530305664] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"324.136514ms","start":"2026-06-24T00:57:58.256672Z","end":"2026-06-24T00:57:58.580808Z","steps":["trace[530305664] 'process raft request' (duration: 322.994597ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:57:58.581396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:57:58.256634Z","time spent":"324.720118ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T00:58:03.198463Z","caller":"traceutil/trace.go:171","msg":"trace[1211516297] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"131.607032ms","start":"2026-06-24T00:58:03.066799Z","end":"2026-06-24T00:58:03.198406Z","steps":["trace[1211516297] 'process raft request' (duration: 49.295012ms)","trace[1211516297] 'compare' (duration: 82.016743ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:58:04.584364Z","caller":"traceutil/trace.go:171","msg":"trace[393234545] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"103.402867ms","start":"2026-06-24T00:58:04.480937Z","end":"2026-06-24T00:58:04.58434Z","steps":["trace[393234545] 'process raft request' (duration: 103.231123ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:58:05.706277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T00:58:05.706357Z","caller":"traceutil/trace.go:171","msg":"trace[1923554225] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1351; }","duration":"578.437472ms","start":"2026-06-24T00:58:05.127902Z","end":"2026-06-24T00:58:05.70634Z","steps":["trace[1923554225] 'count revisions from in-memory index tree' (duration: 578.220048ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:58:05.706398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:58:05.127881Z","time spent":"578.506944ms","remote":"127.0.0.1:50914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":17,"response size":31,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"info","ts":"2026-06-24T00:58:06.118276Z","caller":"traceutil/trace.go:171","msg":"trace[1685050475] linearizableReadLoop","detail":"{readStateIndex:1413; appliedIndex:1412; }","duration":"149.126615ms","start":"2026-06-24T00:58:05.969123Z","end":"2026-06-24T00:58:06.11825Z","steps":["trace[1685050475] 'read index received' (duration: 148.883239ms)","trace[1685050475] 'applied index is now lower than readState.Index' (duration: 242.486µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:58:06.118488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.35041ms","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-24T00:58:06.118525Z","caller":"traceutil/trace.go:171","msg":"trace[1389296507] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1352; }","duration":"149.444422ms","start":"2026-06-24T00:58:05.969068Z","end":"2026-06-24T00:58:06.118512Z","steps":["trace[1389296507] 'agreement among raft nodes before linearized reading' (duration: 149.280918ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:58:06.11857Z","caller":"traceutil/trace.go:171","msg":"trace[1955958304] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"361.203435ms","start":"2026-06-24T00:58:05.757331Z","end":"2026-06-24T00:58:06.118535Z","steps":["trace[1955958304] 'process raft request' (duration: 360.772565ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:58:06.118721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T00:58:05.757307Z","time spent":"361.333978ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T00:58:34.512895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.195949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:58:34.512994Z","caller":"traceutil/trace.go:171","msg":"trace[225287895] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1500; }","duration":"113.346462ms","start":"2026-06-24T00:58:34.399627Z","end":"2026-06-24T00:58:34.512973Z","steps":["trace[225287895] 'count revisions from in-memory index tree' (duration: 113.114106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:58:34.984831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.343929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T00:58:34.984923Z","caller":"traceutil/trace.go:171","msg":"trace[1084923105] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1503; }","duration":"104.492243ms","start":"2026-06-24T00:58:34.880409Z","end":"2026-06-24T00:58:34.984901Z","steps":["trace[1084923105] 'range keys from in-memory index tree' (duration: 104.056543ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:58:35.134796Z","caller":"traceutil/trace.go:171","msg":"trace[974878846] linearizableReadLoop","detail":"{readStateIndex:1572; appliedIndex:1570; }","duration":"141.321851ms","start":"2026-06-24T00:58:34.993436Z","end":"2026-06-24T00:58:35.134758Z","steps":["trace[974878846] 'read index received' (duration: 33.569441ms)","trace[974878846] 'applied index is now lower than readState.Index' (duration: 107.75102ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:58:35.134866Z","caller":"traceutil/trace.go:171","msg":"trace[844171087] transaction","detail":"{read_only:false; response_revision:1505; number_of_response:1; }","duration":"145.51368ms","start":"2026-06-24T00:58:34.989312Z","end":"2026-06-24T00:58:35.134825Z","steps":["trace[844171087] 'process raft request' (duration: 108.18079ms)","trace[844171087] 'compare' (duration: 37.097315ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T00:58:35.135096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.630519ms","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-24T00:58:35.135149Z","caller":"traceutil/trace.go:171","msg":"trace[1184573004] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1505; }","duration":"141.736411ms","start":"2026-06-24T00:58:34.993396Z","end":"2026-06-24T00:58:35.135132Z","steps":["trace[1184573004] 'agreement among raft nodes before linearized reading' (duration: 141.515115ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T00:58:46.541608Z","caller":"traceutil/trace.go:171","msg":"trace[1203463135] transaction","detail":"{read_only:false; response_revision:1555; number_of_response:1; }","duration":"146.859652ms","start":"2026-06-24T00:58:46.394716Z","end":"2026-06-24T00:58:46.541575Z","steps":["trace[1203463135] 'process raft request' (duration: 60.276341ms)","trace[1203463135] 'compare' (duration: 86.434958ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:58:46.713022Z","caller":"traceutil/trace.go:171","msg":"trace[358622799] linearizableReadLoop","detail":"{readStateIndex:1625; appliedIndex:1624; }","duration":"154.714747ms","start":"2026-06-24T00:58:46.558278Z","end":"2026-06-24T00:58:46.712993Z","steps":["trace[358622799] 'read index received' (duration: 154.446821ms)","trace[358622799] 'applied index is now lower than readState.Index' (duration: 266.366µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T00:58:46.713131Z","caller":"traceutil/trace.go:171","msg":"trace[381599025] transaction","detail":"{read_only:false; response_revision:1556; number_of_response:1; }","duration":"166.896204ms","start":"2026-06-24T00:58:46.546209Z","end":"2026-06-24T00:58:46.713106Z","steps":["trace[381599025] 'process raft request' (duration: 166.615987ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T00:58:46.713179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.887701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T00:58:46.713221Z","caller":"traceutil/trace.go:171","msg":"trace[1894263995] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1556; }","duration":"154.962433ms","start":"2026-06-24T00:58:46.558246Z","end":"2026-06-24T00:58:46.713209Z","steps":["trace[1894263995] 'agreement among raft nodes before linearized reading' (duration: 154.857381ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T01:01:21.944234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.731759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-24T01:01:21.944317Z","caller":"traceutil/trace.go:171","msg":"trace[709091604] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2267; }","duration":"111.866123ms","start":"2026-06-24T01:01:21.832434Z","end":"2026-06-24T01:01:21.9443Z","steps":["trace[709091604] 'range keys from in-memory index tree' (duration: 111.552245ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T01:01:25.684022Z","caller":"traceutil/trace.go:171","msg":"trace[362942017] linearizableReadLoop","detail":"{readStateIndex:2385; appliedIndex:2384; }","duration":"159.8214ms","start":"2026-06-24T01:01:25.52417Z","end":"2026-06-24T01:01:25.683991Z","steps":["trace[362942017] 'read index received' (duration: 159.649626ms)","trace[362942017] 'applied index is now lower than readState.Index' (duration: 170.304µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T01:01:25.684165Z","caller":"traceutil/trace.go:171","msg":"trace[469048010] transaction","detail":"{read_only:false; response_revision:2284; number_of_response:1; }","duration":"206.902045ms","start":"2026-06-24T01:01:25.477235Z","end":"2026-06-24T01:01:25.684137Z","steps":["trace[469048010] 'process raft request' (duration: 206.577698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T01:01:25.684501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.323531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-24T01:01:25.68457Z","caller":"traceutil/trace.go:171","msg":"trace[1774626847] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2284; }","duration":"160.468335ms","start":"2026-06-24T01:01:25.524083Z","end":"2026-06-24T01:01:25.684552Z","steps":["trace[1774626847] 'agreement among raft nodes before linearized reading' (duration: 160.063536ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T01:01:26.269388Z","caller":"traceutil/trace.go:171","msg":"trace[1319943085] transaction","detail":"{read_only:false; response_revision:2285; number_of_response:1; }","duration":"581.064267ms","start":"2026-06-24T01:01:25.688293Z","end":"2026-06-24T01:01:26.269357Z","steps":["trace[1319943085] 'process raft request' (duration: 580.085124ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T01:01:26.269573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T01:01:25.688275Z","time spent":"581.214741ms","remote":"127.0.0.1:51116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T01:01:28.704803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.182713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-06-24T01:01:28.704879Z","caller":"traceutil/trace.go:171","msg":"trace[209132176] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2299; }","duration":"226.305146ms","start":"2026-06-24T01:01:28.478556Z","end":"2026-06-24T01:01:28.704861Z","steps":["trace[209132176] 'range keys from in-memory index tree' (duration: 225.970308ms)"],"step_count":1}