{"level":"warn","ts":"2026-06-24T17:13:43.143591Z","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-24T17:13:43.143736Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.70: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.70:2380","--initial-cluster=instance=https://199.204.45.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.70: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-24T17:13:43.143878Z","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-24T17:13:43.143895Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-06-24T17:13:43.143964Z","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-24T17:13:43.145659Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"]} {"level":"info","ts":"2026-06-24T17:13:43.146058Z","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.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.70: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-24T17:13:43.153005Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.268689ms"} {"level":"info","ts":"2026-06-24T17:13:43.161138Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f8844a9a4263041d","cluster-id":"4749b7c221ae0648"} {"level":"info","ts":"2026-06-24T17:13:43.161237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=()"} {"level":"info","ts":"2026-06-24T17:13:43.161265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 0"} {"level":"info","ts":"2026-06-24T17:13:43.161282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f8844a9a4263041d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-24T17:13:43.161297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 1"} {"level":"info","ts":"2026-06-24T17:13:43.161341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"warn","ts":"2026-06-24T17:13:43.168079Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-24T17:13:43.169265Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-24T17:13:43.170511Z","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-24T17:13:43.17282Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f8844a9a4263041d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-24T17:13:43.172959Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f8844a9a4263041d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-24T17:13:43.173187Z","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-24T17:13:43.173241Z","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-24T17:13:43.173253Z","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-24T17:13:43.17554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"info","ts":"2026-06-24T17:13:43.178262Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","added-peer-id":"f8844a9a4263041d","added-peer-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-06-24T17:13:43.179232Z","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-24T17:13:43.179346Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-06-24T17:13:43.179384Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-06-24T17:13:43.17957Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f8844a9a4263041d","initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-24T17:13:43.179611Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-24T17:13:43.962572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d is starting a new election at term 1"} {"level":"info","ts":"2026-06-24T17:13:43.962637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-24T17:13:43.962682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgPreVoteResp from f8844a9a4263041d at term 1"} {"level":"info","ts":"2026-06-24T17:13:43.9627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became candidate at term 2"} {"level":"info","ts":"2026-06-24T17:13:43.962712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgVoteResp from f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-06-24T17:13:43.962736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became leader at term 2"} {"level":"info","ts":"2026-06-24T17:13:43.962758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f8844a9a4263041d elected leader f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-06-24T17:13:43.963978Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f8844a9a4263041d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.70:2379]}","request-path":"/0/members/f8844a9a4263041d/attributes","cluster-id":"4749b7c221ae0648","publish-timeout":"7s"} {"level":"info","ts":"2026-06-24T17:13:43.963979Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T17:13:43.964041Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T17:13:43.964005Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T17:13:43.964398Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-24T17:13:43.964452Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-24T17:13:43.96513Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T17:13:43.965244Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T17:13:43.965279Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T17:13:43.96709Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.70:2379"} {"level":"info","ts":"2026-06-24T17:13:43.967622Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-24T17:13:52.755061Z","caller":"traceutil/trace.go:171","msg":"trace[1946665234] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"137.797925ms","start":"2026-06-24T17:13:52.617248Z","end":"2026-06-24T17:13:52.755046Z","steps":["trace[1946665234] 'process raft request' (duration: 115.956074ms)","trace[1946665234] 'compare' (duration: 21.622216ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:13:52.755254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.843061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-06-24T17:13:52.754964Z","caller":"traceutil/trace.go:171","msg":"trace[103007950] linearizableReadLoop","detail":"{readStateIndex:374; appliedIndex:373; }","duration":"133.540603ms","start":"2026-06-24T17:13:52.6214Z","end":"2026-06-24T17:13:52.754941Z","steps":["trace[103007950] 'read index received' (duration: 111.763294ms)","trace[103007950] 'applied index is now lower than readState.Index' (duration: 21.776359ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:13:52.75532Z","caller":"traceutil/trace.go:171","msg":"trace[446126971] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:364; }","duration":"133.961854ms","start":"2026-06-24T17:13:52.621347Z","end":"2026-06-24T17:13:52.755309Z","steps":["trace[446126971] 'agreement among raft nodes before linearized reading' (duration: 133.841401ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:13:52.944843Z","caller":"traceutil/trace.go:171","msg":"trace[2146752983] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"106.602892ms","start":"2026-06-24T17:13:52.838213Z","end":"2026-06-24T17:13:52.944815Z","steps":["trace[2146752983] 'process raft request' (duration: 78.174434ms)","trace[2146752983] 'compare' (duration: 28.275734ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:13:52.949938Z","caller":"traceutil/trace.go:171","msg":"trace[367637727] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"111.050837ms","start":"2026-06-24T17:13:52.838863Z","end":"2026-06-24T17:13:52.949914Z","steps":["trace[367637727] 'process raft request' (duration: 110.830132ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:13:52.950106Z","caller":"traceutil/trace.go:171","msg":"trace[1055047740] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"105.559706ms","start":"2026-06-24T17:13:52.844523Z","end":"2026-06-24T17:13:52.950083Z","steps":["trace[1055047740] 'process raft request' (duration: 105.496355ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:13:52.950142Z","caller":"traceutil/trace.go:171","msg":"trace[1821972773] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"106.514929ms","start":"2026-06-24T17:13:52.843607Z","end":"2026-06-24T17:13:52.950122Z","steps":["trace[1821972773] 'process raft request' (duration: 106.201512ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:00.284654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.047411ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T17:14:00.284754Z","caller":"traceutil/trace.go:171","msg":"trace[807173190] linearizableReadLoop","detail":"{readStateIndex:421; appliedIndex:420; }","duration":"764.415043ms","start":"2026-06-24T17:13:59.520324Z","end":"2026-06-24T17:14:00.284739Z","steps":["trace[807173190] 'read index received' (duration: 36.2µs)","trace[807173190] 'applied index is now lower than readState.Index' (duration: 764.377713ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:14:00.285038Z","caller":"traceutil/trace.go:171","msg":"trace[1162453550] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"1.091538513s","start":"2026-06-24T17:13:59.193466Z","end":"2026-06-24T17:14:00.285004Z","steps":["trace[1162453550] 'process raft request' (duration: 215.59579ms)","trace[1162453550] 'compare' (duration: 874.892998ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:14:00.285054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.728731ms","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-24T17:14:00.285054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.273102ms","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-24T17:14:00.285061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"680.38505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:14:00.285113Z","caller":"traceutil/trace.go:171","msg":"trace[40068729] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:409; }","duration":"764.836654ms","start":"2026-06-24T17:13:59.52026Z","end":"2026-06-24T17:14:00.285097Z","steps":["trace[40068729] 'agreement among raft nodes before linearized reading' (duration: 764.730851ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:14:00.285115Z","caller":"traceutil/trace.go:171","msg":"trace[1415428371] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:409; }","duration":"585.372485ms","start":"2026-06-24T17:13:59.699728Z","end":"2026-06-24T17:14:00.2851Z","steps":["trace[1415428371] 'agreement among raft nodes before linearized reading' (duration: 585.268612ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:14:00.285146Z","caller":"traceutil/trace.go:171","msg":"trace[1575497053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:409; }","duration":"680.505383ms","start":"2026-06-24T17:13:59.604613Z","end":"2026-06-24T17:14:00.285119Z","steps":["trace[1575497053] 'agreement among raft nodes before linearized reading' (duration: 680.38136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:00.28515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:13:59.52024Z","time spent":"764.901975ms","remote":"127.0.0.1:46988","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-24T17:14:00.28515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:13:59.699705Z","time spent":"585.437657ms","remote":"127.0.0.1:46988","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-24T17:14:00.285188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:13:59.193442Z","time spent":"1.091659815s","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:14:00.285198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:13:59.604589Z","time spent":"680.600235ms","remote":"127.0.0.1:46734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T17:14:00.663862Z","caller":"traceutil/trace.go:171","msg":"trace[1897937104] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"373.460304ms","start":"2026-06-24T17:14:00.290381Z","end":"2026-06-24T17:14:00.663841Z","steps":["trace[1897937104] 'process raft request' (duration: 367.190874ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:00.663978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:00.290353Z","time spent":"373.562376ms","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:14:00.786744Z","caller":"traceutil/trace.go:171","msg":"trace[870351517] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"496.263211ms","start":"2026-06-24T17:14:00.290445Z","end":"2026-06-24T17:14:00.786708Z","steps":["trace[870351517] 'process raft request' (duration: 491.223061ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:00.786956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:00.29043Z","time spent":"496.433335ms","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:14:00.787182Z","caller":"traceutil/trace.go:171","msg":"trace[1220519233] linearizableReadLoop","detail":"{readStateIndex:423; appliedIndex:421; }","duration":"493.28752ms","start":"2026-06-24T17:14:00.293878Z","end":"2026-06-24T17:14:00.787165Z","steps":["trace[1220519233] 'read index received' (duration: 363.708901ms)","trace[1220519233] 'applied index is now lower than readState.Index' (duration: 129.577439ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:14:00.78723Z","caller":"traceutil/trace.go:171","msg":"trace[1936366472] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"490.381321ms","start":"2026-06-24T17:14:00.296822Z","end":"2026-06-24T17:14:00.787203Z","steps":["trace[1936366472] 'process raft request' (duration: 489.790117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:00.787349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.458034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:14:00.787792Z","caller":"traceutil/trace.go:171","msg":"trace[1471844152] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:412; }","duration":"493.932446ms","start":"2026-06-24T17:14:00.293845Z","end":"2026-06-24T17:14:00.787778Z","steps":["trace[1471844152] 'agreement among raft nodes before linearized reading' (duration: 493.446474ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:00.787887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:00.293835Z","time spent":"494.036278ms","remote":"127.0.0.1:46738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T17:14:00.78827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:00.296812Z","time spent":"490.824731ms","remote":"127.0.0.1:46896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7279,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:14:24.244683Z","caller":"traceutil/trace.go:171","msg":"trace[1845914290] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"318.325438ms","start":"2026-06-24T17:14:23.926338Z","end":"2026-06-24T17:14:24.244664Z","steps":["trace[1845914290] 'process raft request' (duration: 318.192385ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:24.244801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:23.926318Z","time spent":"318.434142ms","remote":"127.0.0.1:46792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:14:24.255192Z","caller":"traceutil/trace.go:171","msg":"trace[426600702] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"252.959811ms","start":"2026-06-24T17:14:24.002212Z","end":"2026-06-24T17:14:24.255172Z","steps":["trace[426600702] 'process raft request' (duration: 251.941667ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:14:24.924626Z","caller":"traceutil/trace.go:171","msg":"trace[1586287742] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"405.967109ms","start":"2026-06-24T17:14:24.518615Z","end":"2026-06-24T17:14:24.924582Z","steps":["trace[1586287742] 'process raft request' (duration: 405.515658ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:24.925327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:24.518595Z","time spent":"406.129392ms","remote":"127.0.0.1:46792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:14:25.097273Z","caller":"traceutil/trace.go:171","msg":"trace[49553438] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:626; }","duration":"522.799464ms","start":"2026-06-24T17:14:24.574437Z","end":"2026-06-24T17:14:25.097236Z","steps":["trace[49553438] 'read index received' (duration: 349.576064ms)","trace[49553438] 'applied index is now lower than readState.Index' (duration: 173.22248ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:14:25.097595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.841256ms","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-24T17:14:25.097655Z","caller":"traceutil/trace.go:171","msg":"trace[1773913314] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:605; }","duration":"322.96447ms","start":"2026-06-24T17:14:24.77468Z","end":"2026-06-24T17:14:25.097644Z","steps":["trace[1773913314] 'agreement among raft nodes before linearized reading' (duration: 322.876768ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:25.097692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:24.774657Z","time spent":"323.028391ms","remote":"127.0.0.1:46988","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-24T17:14:25.097743Z","caller":"traceutil/trace.go:171","msg":"trace[381545944] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"564.725683ms","start":"2026-06-24T17:14:24.532998Z","end":"2026-06-24T17:14:25.097723Z","steps":["trace[381545944] 'process raft request' (duration: 546.911639ms)","trace[381545944] 'compare' (duration: 17.244361ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:14:25.097864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:24.532983Z","time spent":"564.812265ms","remote":"127.0.0.1:46792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:14:25.097951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.067463ms","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-24T17:14:25.098001Z","caller":"traceutil/trace.go:171","msg":"trace[1987615326] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:605; }","duration":"214.152205ms","start":"2026-06-24T17:14:24.883841Z","end":"2026-06-24T17:14:25.097993Z","steps":["trace[1987615326] 'agreement among raft nodes before linearized reading' (duration: 214.055623ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:25.09768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.226154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:151236"} {"level":"info","ts":"2026-06-24T17:14:25.09813Z","caller":"traceutil/trace.go:171","msg":"trace[127258724] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:605; }","duration":"523.723296ms","start":"2026-06-24T17:14:24.574399Z","end":"2026-06-24T17:14:25.098122Z","steps":["trace[127258724] 'agreement among raft nodes before linearized reading' (duration: 523.122912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:25.098165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:24.574391Z","time spent":"523.766647ms","remote":"127.0.0.1:46792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":1,"response size":151259,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-06-24T17:14:30.6123Z","caller":"traceutil/trace.go:171","msg":"trace[1186280246] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"196.448653ms","start":"2026-06-24T17:14:30.415825Z","end":"2026-06-24T17:14:30.612274Z","steps":["trace[1186280246] 'read index received' (duration: 195.808577ms)","trace[1186280246] 'applied index is now lower than readState.Index' (duration: 638.966µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:14:30.612452Z","caller":"traceutil/trace.go:171","msg":"trace[1919067422] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"352.689248ms","start":"2026-06-24T17:14:30.259733Z","end":"2026-06-24T17:14:30.612422Z","steps":["trace[1919067422] 'process raft request' (duration: 352.113225ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:30.612494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.653278ms","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-24T17:14:30.612527Z","caller":"traceutil/trace.go:171","msg":"trace[7534876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:640; }","duration":"196.734ms","start":"2026-06-24T17:14:30.415784Z","end":"2026-06-24T17:14:30.612518Z","steps":["trace[7534876] 'agreement among raft nodes before linearized reading' (duration: 196.592356ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:30.6126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:30.259705Z","time spent":"352.822101ms","remote":"127.0.0.1:46844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:14:31.137241Z","caller":"traceutil/trace.go:171","msg":"trace[1783854511] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:665; }","duration":"285.146848ms","start":"2026-06-24T17:14:30.852052Z","end":"2026-06-24T17:14:31.137199Z","steps":["trace[1783854511] 'read index received' (duration: 284.779779ms)","trace[1783854511] 'applied index is now lower than readState.Index' (duration: 365.389µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:14:31.137354Z","caller":"traceutil/trace.go:171","msg":"trace[329609947] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"467.574247ms","start":"2026-06-24T17:14:30.669741Z","end":"2026-06-24T17:14:31.137315Z","steps":["trace[329609947] 'process raft request' (duration: 467.214468ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:31.137497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:30.669703Z","time spent":"467.728171ms","remote":"127.0.0.1:46968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T17:14:31.137539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.415924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:14:31.137586Z","caller":"traceutil/trace.go:171","msg":"trace[740641550] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"285.524947ms","start":"2026-06-24T17:14:30.852046Z","end":"2026-06-24T17:14:31.137571Z","steps":["trace[740641550] 'agreement among raft nodes before linearized reading' (duration: 285.356743ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:31.137929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.246437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-x5vmp\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-24T17:14:31.138098Z","caller":"traceutil/trace.go:171","msg":"trace[1783742731] range","detail":"{range_begin:/registry/pods/kube-system/cilium-x5vmp; range_end:; response_count:1; response_revision:642; }","duration":"266.470043ms","start":"2026-06-24T17:14:30.8716Z","end":"2026-06-24T17:14:31.13807Z","steps":["trace[1783742731] 'agreement among raft nodes before linearized reading' (duration: 266.119425ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:14:31.482654Z","caller":"traceutil/trace.go:171","msg":"trace[1033497842] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"328.994573ms","start":"2026-06-24T17:14:31.153627Z","end":"2026-06-24T17:14:31.482621Z","steps":["trace[1033497842] 'process raft request' (duration: 297.132924ms)","trace[1033497842] 'compare' (duration: 31.704756ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:14:31.482807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:31.153604Z","time spent":"329.131387ms","remote":"127.0.0.1:46896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:14:31.508956Z","caller":"traceutil/trace.go:171","msg":"trace[1573146743] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:666; }","duration":"336.654696ms","start":"2026-06-24T17:14:31.172268Z","end":"2026-06-24T17:14:31.508923Z","steps":["trace[1573146743] 'read index received' (duration: 278.535151ms)","trace[1573146743] 'applied index is now lower than readState.Index' (duration: 58.118285ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:14:31.509281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.992754ms","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-24T17:14:31.509422Z","caller":"traceutil/trace.go:171","msg":"trace[258309942] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:644; }","duration":"337.182088ms","start":"2026-06-24T17:14:31.172219Z","end":"2026-06-24T17:14:31.509401Z","steps":["trace[258309942] 'agreement among raft nodes before linearized reading' (duration: 336.855121ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:31.509588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:31.172197Z","time spent":"337.349372ms","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T17:14:31.509809Z","caller":"traceutil/trace.go:171","msg":"trace[199414417] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"351.257284ms","start":"2026-06-24T17:14:31.1585Z","end":"2026-06-24T17:14:31.509757Z","steps":["trace[199414417] 'process raft request' (duration: 350.24039ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:31.510094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:31.158413Z","time spent":"351.51578ms","remote":"127.0.0.1:46896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:14:32.010141Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296567949732740684,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T17:14:32.503995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.819888ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T17:14:32.504458Z","caller":"traceutil/trace.go:171","msg":"trace[1323851659] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"1.016123795s","start":"2026-06-24T17:14:31.488316Z","end":"2026-06-24T17:14:32.50444Z","steps":["trace[1323851659] 'process raft request' (duration: 629.801525ms)","trace[1323851659] 'compare' (duration: 385.720375ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:14:32.504514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:31.488298Z","time spent":"1.016193586s","remote":"127.0.0.1:46818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:14:32.504503Z","caller":"traceutil/trace.go:171","msg":"trace[1012165700] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"1.016152935s","start":"2026-06-24T17:14:31.488317Z","end":"2026-06-24T17:14:32.50447Z","steps":["trace[1012165700] 'process raft request' (duration: 1.015765786s)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:14:32.504594Z","caller":"traceutil/trace.go:171","msg":"trace[535605924] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"1.012353654s","start":"2026-06-24T17:14:31.492203Z","end":"2026-06-24T17:14:32.504557Z","steps":["trace[535605924] 'process raft request' (duration: 1.011972505s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:32.504642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:31.488298Z","time spent":"1.016269798s","remote":"127.0.0.1:46818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T17:14:32.504637Z","caller":"traceutil/trace.go:171","msg":"trace[1053194591] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"1.015282454s","start":"2026-06-24T17:14:31.489316Z","end":"2026-06-24T17:14:32.504599Z","steps":["trace[1053194591] 'process raft request' (duration: 1.014810823s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:32.504695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:31.49219Z","time spent":"1.012455697s","remote":"127.0.0.1:46896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:14:32.504733Z","caller":"traceutil/trace.go:171","msg":"trace[553331320] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"988.695591ms","start":"2026-06-24T17:14:31.516029Z","end":"2026-06-24T17:14:32.504724Z","steps":["trace[553331320] 'process raft request' (duration: 988.191999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:32.504775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:31.516004Z","time spent":"988.748012ms","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:14:32.504792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:31.48931Z","time spent":"1.015392537s","remote":"127.0.0.1:46968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:14:32.504861Z","caller":"traceutil/trace.go:171","msg":"trace[1280188133] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:668; }","duration":"995.772319ms","start":"2026-06-24T17:14:31.509076Z","end":"2026-06-24T17:14:32.504848Z","steps":["trace[1280188133] 'read index received' (duration: 609.036219ms)","trace[1280188133] 'applied index is now lower than readState.Index' (duration: 386.73366ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:14:32.518659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060746118s","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-24T17:14:32.518716Z","caller":"traceutil/trace.go:171","msg":"trace[1576469715] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:649; }","duration":"1.060846591s","start":"2026-06-24T17:14:31.457856Z","end":"2026-06-24T17:14:32.518702Z","steps":["trace[1576469715] 'agreement among raft nodes before linearized reading' (duration: 1.047055512s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:32.518744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:31.457834Z","time spent":"1.060902801s","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T17:14:32.518825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.339361871s","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-24T17:14:32.518856Z","caller":"traceutil/trace.go:171","msg":"trace[300475036] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:649; }","duration":"1.339451823s","start":"2026-06-24T17:14:31.179396Z","end":"2026-06-24T17:14:32.518847Z","steps":["trace[300475036] 'agreement among raft nodes before linearized reading' (duration: 1.325522941s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:32.518886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:31.179381Z","time spent":"1.339499684s","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T17:14:32.519017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.860592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:14:32.519039Z","caller":"traceutil/trace.go:171","msg":"trace[1571948941] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:649; }","duration":"667.916443ms","start":"2026-06-24T17:14:31.851116Z","end":"2026-06-24T17:14:32.519032Z","steps":["trace[1571948941] 'agreement among raft nodes before linearized reading' (duration: 667.881273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:32.519058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:14:31.851097Z","time spent":"667.956024ms","remote":"127.0.0.1:46734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T17:14:34.194522Z","caller":"traceutil/trace.go:171","msg":"trace[212776622] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"136.017433ms","start":"2026-06-24T17:14:34.058448Z","end":"2026-06-24T17:14:34.194466Z","steps":["trace[212776622] 'process raft request' (duration: 135.762536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:47.926143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.984096ms","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-24T17:14:47.926271Z","caller":"traceutil/trace.go:171","msg":"trace[533619595] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:800; }","duration":"158.194521ms","start":"2026-06-24T17:14:47.768051Z","end":"2026-06-24T17:14:47.926245Z","steps":["trace[533619595] 'range keys from in-memory index tree' (duration: 157.626718ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:14:48.178455Z","caller":"traceutil/trace.go:171","msg":"trace[206122905] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:831; }","duration":"210.491761ms","start":"2026-06-24T17:14:47.967936Z","end":"2026-06-24T17:14:48.178427Z","steps":["trace[206122905] 'read index received' (duration: 210.157193ms)","trace[206122905] 'applied index is now lower than readState.Index' (duration: 333.238µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:14:48.178606Z","caller":"traceutil/trace.go:171","msg":"trace[639349567] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"247.062169ms","start":"2026-06-24T17:14:47.931501Z","end":"2026-06-24T17:14:48.178564Z","steps":["trace[639349567] 'process raft request' (duration: 246.743671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:48.178915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.944702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-j2294\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-06-24T17:14:48.17949Z","caller":"traceutil/trace.go:171","msg":"trace[709459012] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-j2294; range_end:; response_count:1; response_revision:801; }","duration":"211.529276ms","start":"2026-06-24T17:14:47.967927Z","end":"2026-06-24T17:14:48.179456Z","steps":["trace[709459012] 'agreement among raft nodes before linearized reading' (duration: 210.774397ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:14:52.753846Z","caller":"traceutil/trace.go:171","msg":"trace[130686939] linearizableReadLoop","detail":"{readStateIndex:881; appliedIndex:880; }","duration":"160.679722ms","start":"2026-06-24T17:14:52.593146Z","end":"2026-06-24T17:14:52.753825Z","steps":["trace[130686939] 'read index received' (duration: 89.694848ms)","trace[130686939] 'applied index is now lower than readState.Index' (duration: 70.983924ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:14:52.753876Z","caller":"traceutil/trace.go:171","msg":"trace[1654273176] transaction","detail":"{read_only:false; response_revision:849; number_of_response:1; }","duration":"161.021879ms","start":"2026-06-24T17:14:52.592831Z","end":"2026-06-24T17:14:52.753853Z","steps":["trace[1654273176] 'process raft request' (duration: 90.092527ms)","trace[1654273176] 'compare' (duration: 70.782959ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:14:52.754106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.945128ms","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-24T17:14:52.754106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.148718ms","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-24T17:14:52.754152Z","caller":"traceutil/trace.go:171","msg":"trace[1253050816] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:849; }","duration":"146.22976ms","start":"2026-06-24T17:14:52.607912Z","end":"2026-06-24T17:14:52.754142Z","steps":["trace[1253050816] 'agreement among raft nodes before linearized reading' (duration: 146.048306ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:14:52.754182Z","caller":"traceutil/trace.go:171","msg":"trace[380155087] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:849; }","duration":"161.012399ms","start":"2026-06-24T17:14:52.593126Z","end":"2026-06-24T17:14:52.754138Z","steps":["trace[380155087] 'agreement among raft nodes before linearized reading' (duration: 160.781474ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:14:52.754315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.769764ms","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-24T17:14:52.754357Z","caller":"traceutil/trace.go:171","msg":"trace[1535313498] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:849; }","duration":"144.812115ms","start":"2026-06-24T17:14:52.609538Z","end":"2026-06-24T17:14:52.75435Z","steps":["trace[1535313498] 'agreement among raft nodes before linearized reading' (duration: 144.730363ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:15:23.416359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.742332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:15:23.416461Z","caller":"traceutil/trace.go:171","msg":"trace[343335598] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1016; }","duration":"564.889325ms","start":"2026-06-24T17:15:22.851552Z","end":"2026-06-24T17:15:23.416441Z","steps":["trace[343335598] 'range keys from in-memory index tree' (duration: 564.629628ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:15:23.416501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:15:22.851535Z","time spent":"564.957097ms","remote":"127.0.0.1:46734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T17:15:23.416755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.173184ms","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-24T17:15:23.416853Z","caller":"traceutil/trace.go:171","msg":"trace[805805001] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1016; }","duration":"486.296367ms","start":"2026-06-24T17:15:22.930531Z","end":"2026-06-24T17:15:23.416828Z","steps":["trace[805805001] 'range keys from in-memory index tree' (duration: 486.026391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:15:23.416879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.242793ms","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-24T17:15:23.416907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:15:22.930522Z","time spent":"486.370708ms","remote":"127.0.0.1:46988","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-24T17:15:23.416916Z","caller":"traceutil/trace.go:171","msg":"trace[1565084241] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1016; }","duration":"490.308614ms","start":"2026-06-24T17:15:22.926597Z","end":"2026-06-24T17:15:23.416905Z","steps":["trace[1565084241] 'range keys from in-memory index tree' (duration: 490.102319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:15:23.416917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.956556ms","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-24T17:15:23.416953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:15:22.926581Z","time spent":"490.365496ms","remote":"127.0.0.1:46988","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-24T17:15:23.416978Z","caller":"traceutil/trace.go:171","msg":"trace[66678919] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1016; }","duration":"490.033877ms","start":"2026-06-24T17:15:22.926925Z","end":"2026-06-24T17:15:23.416959Z","steps":["trace[66678919] 'range keys from in-memory index tree' (duration: 489.847553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:15:23.417027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:15:22.926916Z","time spent":"490.100099ms","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T17:15:23.417094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.347603ms","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-24T17:15:23.417234Z","caller":"traceutil/trace.go:171","msg":"trace[1351322308] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1016; }","duration":"492.568429ms","start":"2026-06-24T17:15:22.924639Z","end":"2026-06-24T17:15:23.417208Z","steps":["trace[1351322308] 'range keys from in-memory index tree' (duration: 491.490212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:15:23.417289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:15:22.924623Z","time spent":"492.651291ms","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-24T17:15:23.64943Z","caller":"traceutil/trace.go:171","msg":"trace[1466055164] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"227.679718ms","start":"2026-06-24T17:15:23.421729Z","end":"2026-06-24T17:15:23.649409Z","steps":["trace[1466055164] 'process raft request' (duration: 227.528224ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:15:23.877156Z","caller":"traceutil/trace.go:171","msg":"trace[1622457886] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"455.323966ms","start":"2026-06-24T17:15:23.421812Z","end":"2026-06-24T17:15:23.877136Z","steps":["trace[1622457886] 'process raft request' (duration: 455.152752ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:15:23.877285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:15:23.421801Z","time spent":"455.417798ms","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:15:23.877452Z","caller":"traceutil/trace.go:171","msg":"trace[1266257244] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"455.518491ms","start":"2026-06-24T17:15:23.421897Z","end":"2026-06-24T17:15:23.877415Z","steps":["trace[1266257244] 'process raft request' (duration: 455.203893ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:15:23.877524Z","caller":"traceutil/trace.go:171","msg":"trace[1761744594] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"330.092546ms","start":"2026-06-24T17:15:23.547401Z","end":"2026-06-24T17:15:23.877493Z","steps":["trace[1761744594] 'process raft request' (duration: 330.049354ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:15:23.877581Z","caller":"traceutil/trace.go:171","msg":"trace[531658199] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"455.057099ms","start":"2026-06-24T17:15:23.422497Z","end":"2026-06-24T17:15:23.877554Z","steps":["trace[531658199] 'process raft request' (duration: 454.845134ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:15:23.877631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:15:23.421864Z","time spent":"455.671705ms","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:15:23.877675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:15:23.547373Z","time spent":"330.223358ms","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:15:23.877916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:15:23.42247Z","time spent":"455.178462ms","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:15:32.198906Z","caller":"traceutil/trace.go:171","msg":"trace[1775032108] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"210.662625ms","start":"2026-06-24T17:15:31.988225Z","end":"2026-06-24T17:15:32.198887Z","steps":["trace[1775032108] 'process raft request' (duration: 182.777348ms)","trace[1775032108] 'compare' (duration: 27.812525ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:15:32.214203Z","caller":"traceutil/trace.go:171","msg":"trace[1126423893] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"223.937268ms","start":"2026-06-24T17:15:31.990247Z","end":"2026-06-24T17:15:32.214185Z","steps":["trace[1126423893] 'process raft request' (duration: 223.848035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:15:32.424052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.665715ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-06-24T17:15:44.790457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.538876ms","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-24T17:15:44.790555Z","caller":"traceutil/trace.go:171","msg":"trace[803969612] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1087; }","duration":"237.69318ms","start":"2026-06-24T17:15:44.55284Z","end":"2026-06-24T17:15:44.790533Z","steps":["trace[803969612] 'range keys from in-memory index tree' (duration: 237.327791ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:15:45.099008Z","caller":"traceutil/trace.go:171","msg":"trace[251268440] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"304.199336ms","start":"2026-06-24T17:15:44.794787Z","end":"2026-06-24T17:15:45.098986Z","steps":["trace[251268440] 'process raft request' (duration: 304.046262ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:15:45.099128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:15:44.794765Z","time spent":"304.300519ms","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T17:15:45.987691Z","caller":"traceutil/trace.go:171","msg":"trace[1459267540] linearizableReadLoop","detail":"{readStateIndex:1132; appliedIndex:1131; }","duration":"135.256324ms","start":"2026-06-24T17:15:45.852412Z","end":"2026-06-24T17:15:45.987669Z","steps":["trace[1459267540] 'read index received' (duration: 135.125671ms)","trace[1459267540] 'applied index is now lower than readState.Index' (duration: 129.473µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:15:45.987798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.373087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:15:45.987826Z","caller":"traceutil/trace.go:171","msg":"trace[382369922] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1089; }","duration":"135.465819ms","start":"2026-06-24T17:15:45.852352Z","end":"2026-06-24T17:15:45.987818Z","steps":["trace[382369922] 'agreement among raft nodes before linearized reading' (duration: 135.401967ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:15:45.987807Z","caller":"traceutil/trace.go:171","msg":"trace[650248066] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"166.966844ms","start":"2026-06-24T17:15:45.820817Z","end":"2026-06-24T17:15:45.987783Z","steps":["trace[650248066] 'process raft request' (duration: 166.725458ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:15:46.437586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.23117ms","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-24T17:15:46.437704Z","caller":"traceutil/trace.go:171","msg":"trace[1176190149] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1089; }","duration":"328.360593ms","start":"2026-06-24T17:15:46.109325Z","end":"2026-06-24T17:15:46.437685Z","steps":["trace[1176190149] 'range keys from in-memory index tree' (duration: 328.21629ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:15:46.437641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.025929ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T17:15:46.437897Z","caller":"traceutil/trace.go:171","msg":"trace[2040480997] linearizableReadLoop","detail":"{readStateIndex:1133; appliedIndex:1132; }","duration":"402.523914ms","start":"2026-06-24T17:15:46.035364Z","end":"2026-06-24T17:15:46.437888Z","steps":["trace[2040480997] 'read index received' (duration: 164.247758ms)","trace[2040480997] 'applied index is now lower than readState.Index' (duration: 238.275176ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:15:46.437934Z","caller":"traceutil/trace.go:171","msg":"trace[346551016] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"430.635726ms","start":"2026-06-24T17:15:46.007264Z","end":"2026-06-24T17:15:46.4379Z","steps":["trace[346551016] 'process raft request' (duration: 192.293199ms)","trace[346551016] 'compare' (duration: 237.772933ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:15:46.438026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:15:46.007239Z","time spent":"430.719129ms","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:15:46.438046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.683368ms","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-24T17:15:46.438084Z","caller":"traceutil/trace.go:171","msg":"trace[2073160121] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1090; }","duration":"402.749769ms","start":"2026-06-24T17:15:46.035321Z","end":"2026-06-24T17:15:46.438071Z","steps":["trace[2073160121] 'agreement among raft nodes before linearized reading' (duration: 402.597706ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:15:46.438115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:15:46.035306Z","time spent":"402.80122ms","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-24T17:15:46.438161Z","caller":"traceutil/trace.go:171","msg":"trace[1739305149] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1090; }","duration":"100.003428ms","start":"2026-06-24T17:15:46.338135Z","end":"2026-06-24T17:15:46.438139Z","steps":["trace[1739305149] 'agreement among raft nodes before linearized reading' (duration: 99.869335ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:15:46.438549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.819265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-24T17:15:46.4386Z","caller":"traceutil/trace.go:171","msg":"trace[2095896321] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1090; }","duration":"118.921338ms","start":"2026-06-24T17:15:46.319667Z","end":"2026-06-24T17:15:46.438589Z","steps":["trace[2095896321] 'agreement among raft nodes before linearized reading' (duration: 118.287013ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:02.590994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.973133ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-24T17:16:02.598031Z","caller":"traceutil/trace.go:171","msg":"trace[1409172983] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"105.355755ms","start":"2026-06-24T17:16:02.492651Z","end":"2026-06-24T17:16:02.598007Z","steps":["trace[1409172983] 'process raft request' (duration: 105.162421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:04.014355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.353995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:16:04.014432Z","caller":"traceutil/trace.go:171","msg":"trace[1195551289] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1199; }","duration":"376.479388ms","start":"2026-06-24T17:16:03.637937Z","end":"2026-06-24T17:16:04.014417Z","steps":["trace[1195551289] 'range keys from in-memory index tree' (duration: 376.249872ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:04.014466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:16:03.63791Z","time spent":"376.548609ms","remote":"127.0.0.1:46734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T17:16:04.014622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.310662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:16:04.014686Z","caller":"traceutil/trace.go:171","msg":"trace[1037021045] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1199; }","duration":"162.425215ms","start":"2026-06-24T17:16:03.852247Z","end":"2026-06-24T17:16:04.014673Z","steps":["trace[1037021045] 'range keys from in-memory index tree' (duration: 162.2002ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:04.014689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.26006ms","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-24T17:16:04.014716Z","caller":"traceutil/trace.go:171","msg":"trace[1326899628] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1199; }","duration":"518.323022ms","start":"2026-06-24T17:16:03.496384Z","end":"2026-06-24T17:16:04.014707Z","steps":["trace[1326899628] 'count revisions from in-memory index tree' (duration: 518.132177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:04.014736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:16:03.496365Z","time spent":"518.365223ms","remote":"127.0.0.1:36180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-06-24T17:16:04.4636Z","caller":"traceutil/trace.go:171","msg":"trace[579852615] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"283.039663ms","start":"2026-06-24T17:16:04.180538Z","end":"2026-06-24T17:16:04.463578Z","steps":["trace[579852615] 'process raft request' (duration: 282.9199ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:16:21.415558Z","caller":"traceutil/trace.go:171","msg":"trace[144040545] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"109.040086ms","start":"2026-06-24T17:16:21.306486Z","end":"2026-06-24T17:16:21.415526Z","steps":["trace[144040545] 'process raft request' (duration: 108.847171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:21.800464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.868603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T17:16:21.80054Z","caller":"traceutil/trace.go:171","msg":"trace[335055291] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1280; }","duration":"114.036347ms","start":"2026-06-24T17:16:21.686487Z","end":"2026-06-24T17:16:21.800524Z","steps":["trace[335055291] 'count revisions from in-memory index tree' (duration: 113.737249ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:22.866327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.139739ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-24T17:16:22.866546Z","caller":"traceutil/trace.go:171","msg":"trace[473380530] linearizableReadLoop","detail":"{readStateIndex:1333; appliedIndex:1332; }","duration":"438.271353ms","start":"2026-06-24T17:16:22.428254Z","end":"2026-06-24T17:16:22.866526Z","steps":["trace[473380530] 'read index received' (duration: 160.904908ms)","trace[473380530] 'applied index is now lower than readState.Index' (duration: 277.365545ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:16:22.866662Z","caller":"traceutil/trace.go:171","msg":"trace[758817009] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"134.028064ms","start":"2026-06-24T17:16:22.732606Z","end":"2026-06-24T17:16:22.866634Z","steps":["trace[758817009] 'process raft request' (duration: 133.829539ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:22.866714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.430756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:16:22.866789Z","caller":"traceutil/trace.go:171","msg":"trace[2024148967] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1281; }","duration":"438.521569ms","start":"2026-06-24T17:16:22.428248Z","end":"2026-06-24T17:16:22.86677Z","steps":["trace[2024148967] 'agreement among raft nodes before linearized reading' (duration: 438.347574ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:22.866806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.677022ms","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-24T17:16:22.866831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:16:22.428229Z","time spent":"438.592381ms","remote":"127.0.0.1:48822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-24T17:16:22.866862Z","caller":"traceutil/trace.go:171","msg":"trace[372492374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1281; }","duration":"293.778274ms","start":"2026-06-24T17:16:22.57307Z","end":"2026-06-24T17:16:22.866849Z","steps":["trace[372492374] 'agreement among raft nodes before linearized reading' (duration: 293.57795ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:25.392678Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296567949732742143,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T17:16:25.448317Z","caller":"traceutil/trace.go:171","msg":"trace[69008831] linearizableReadLoop","detail":"{readStateIndex:1341; appliedIndex:1340; }","duration":"556.725217ms","start":"2026-06-24T17:16:24.891569Z","end":"2026-06-24T17:16:25.448294Z","steps":["trace[69008831] 'read index received' (duration: 556.499202ms)","trace[69008831] 'applied index is now lower than readState.Index' (duration: 225.205µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:16:25.448641Z","caller":"traceutil/trace.go:171","msg":"trace[1387294212] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"577.314248ms","start":"2026-06-24T17:16:24.871312Z","end":"2026-06-24T17:16:25.448626Z","steps":["trace[1387294212] 'process raft request' (duration: 576.820456ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:25.448744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:16:24.871288Z","time spent":"577.39057ms","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T17:16:25.448991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.427554ms","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-24T17:16:25.449032Z","caller":"traceutil/trace.go:171","msg":"trace[47465731] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1288; }","duration":"557.506896ms","start":"2026-06-24T17:16:24.891516Z","end":"2026-06-24T17:16:25.449023Z","steps":["trace[47465731] 'agreement among raft nodes before linearized reading' (duration: 557.393683ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:25.449063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:16:24.891496Z","time spent":"557.557987ms","remote":"127.0.0.1:46988","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-24T17:16:25.449316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.26885ms","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-24T17:16:25.449359Z","caller":"traceutil/trace.go:171","msg":"trace[1756716682] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1288; }","duration":"504.335282ms","start":"2026-06-24T17:16:24.945011Z","end":"2026-06-24T17:16:25.449347Z","steps":["trace[1756716682] 'agreement among raft nodes before linearized reading' (duration: 504.240319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:25.449387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:16:24.944996Z","time spent":"504.384742ms","remote":"127.0.0.1:46988","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-24T17:16:25.449654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.350735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:16:25.449694Z","caller":"traceutil/trace.go:171","msg":"trace[365788181] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1288; }","duration":"275.424027ms","start":"2026-06-24T17:16:25.174259Z","end":"2026-06-24T17:16:25.449683Z","steps":["trace[365788181] 'agreement among raft nodes before linearized reading' (duration: 275.354185ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:25.449882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.447343ms","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-24T17:16:25.449914Z","caller":"traceutil/trace.go:171","msg":"trace[595041447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1288; }","duration":"504.493335ms","start":"2026-06-24T17:16:24.945413Z","end":"2026-06-24T17:16:25.449906Z","steps":["trace[595041447] 'agreement among raft nodes before linearized reading' (duration: 504.413123ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:25.449938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:16:24.945405Z","time spent":"504.527166ms","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T17:16:25.450157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.827093ms","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-24T17:16:25.450194Z","caller":"traceutil/trace.go:171","msg":"trace[1152804946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1288; }","duration":"504.890345ms","start":"2026-06-24T17:16:24.945295Z","end":"2026-06-24T17:16:25.450186Z","steps":["trace[1152804946] 'agreement among raft nodes before linearized reading' (duration: 504.791783ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:25.450223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:16:24.945278Z","time spent":"504.937656ms","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-24T17:16:37.334379Z","caller":"traceutil/trace.go:171","msg":"trace[1582199265] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"115.058532ms","start":"2026-06-24T17:16:37.219284Z","end":"2026-06-24T17:16:37.334343Z","steps":["trace[1582199265] 'process raft request' (duration: 55.02039ms)","trace[1582199265] 'compare' (duration: 59.900739ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:16:47.816102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.135193ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T17:16:47.816224Z","caller":"traceutil/trace.go:171","msg":"trace[507479904] linearizableReadLoop","detail":"{readStateIndex:1472; appliedIndex:1471; }","duration":"206.657002ms","start":"2026-06-24T17:16:47.609545Z","end":"2026-06-24T17:16:47.816202Z","steps":["trace[507479904] 'read index received' (duration: 36.250023ms)","trace[507479904] 'applied index is now lower than readState.Index' (duration: 170.404829ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:16:47.81626Z","caller":"traceutil/trace.go:171","msg":"trace[1135495674] transaction","detail":"{read_only:false; response_revision:1414; number_of_response:1; }","duration":"233.130267ms","start":"2026-06-24T17:16:47.583103Z","end":"2026-06-24T17:16:47.816234Z","steps":["trace[1135495674] 'process raft request' (duration: 62.771949ms)","trace[1135495674] 'compare' (duration: 169.910247ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:16:47.816459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.903498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-06-24T17:16:47.816498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.548589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-24T17:16:47.816519Z","caller":"traceutil/trace.go:171","msg":"trace[2023297376] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1414; }","duration":"207.004161ms","start":"2026-06-24T17:16:47.609499Z","end":"2026-06-24T17:16:47.816503Z","steps":["trace[2023297376] 'agreement among raft nodes before linearized reading' (duration: 206.817256ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:16:47.816551Z","caller":"traceutil/trace.go:171","msg":"trace[2089943998] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1414; }","duration":"153.712164ms","start":"2026-06-24T17:16:47.662825Z","end":"2026-06-24T17:16:47.816537Z","steps":["trace[2089943998] 'agreement among raft nodes before linearized reading' (duration: 153.57384ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:47.816738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.480777ms","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-24T17:16:47.816791Z","caller":"traceutil/trace.go:171","msg":"trace[86127949] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1414; }","duration":"100.567549ms","start":"2026-06-24T17:16:47.716211Z","end":"2026-06-24T17:16:47.816778Z","steps":["trace[86127949] 'agreement among raft nodes before linearized reading' (duration: 100.448457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:48.035012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.675136ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T17:16:48.035372Z","caller":"traceutil/trace.go:171","msg":"trace[1127599691] transaction","detail":"{read_only:false; response_revision:1416; number_of_response:1; }","duration":"213.491839ms","start":"2026-06-24T17:16:47.821837Z","end":"2026-06-24T17:16:48.035329Z","steps":["trace[1127599691] 'process raft request' (duration: 111.418963ms)","trace[1127599691] 'compare' (duration: 101.574103ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:16:48.035437Z","caller":"traceutil/trace.go:171","msg":"trace[1859792435] transaction","detail":"{read_only:false; response_revision:1417; number_of_response:1; }","duration":"213.54911ms","start":"2026-06-24T17:16:47.821844Z","end":"2026-06-24T17:16:48.035393Z","steps":["trace[1859792435] 'process raft request' (duration: 213.264563ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:16:48.035556Z","caller":"traceutil/trace.go:171","msg":"trace[659467374] transaction","detail":"{read_only:false; response_revision:1419; number_of_response:1; }","duration":"212.939926ms","start":"2026-06-24T17:16:47.822606Z","end":"2026-06-24T17:16:48.035546Z","steps":["trace[659467374] 'process raft request' (duration: 212.777192ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:16:48.035555Z","caller":"traceutil/trace.go:171","msg":"trace[720225835] linearizableReadLoop","detail":"{readStateIndex:1479; appliedIndex:1472; }","duration":"183.320504ms","start":"2026-06-24T17:16:47.852213Z","end":"2026-06-24T17:16:48.035533Z","steps":["trace[720225835] 'read index received' (duration: 21.35305ms)","trace[720225835] 'applied index is now lower than readState.Index' (duration: 161.966234ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:16:48.035649Z","caller":"traceutil/trace.go:171","msg":"trace[846342842] transaction","detail":"{read_only:false; response_revision:1418; number_of_response:1; }","duration":"213.479809ms","start":"2026-06-24T17:16:47.822161Z","end":"2026-06-24T17:16:48.035641Z","steps":["trace[846342842] 'process raft request' (duration: 213.010928ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:16:48.035679Z","caller":"traceutil/trace.go:171","msg":"trace[132201075] transaction","detail":"{read_only:false; response_revision:1420; number_of_response:1; }","duration":"213.022648ms","start":"2026-06-24T17:16:47.822641Z","end":"2026-06-24T17:16:48.035663Z","steps":["trace[132201075] 'process raft request' (duration: 212.799292ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:48.035787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.56661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:16:48.035829Z","caller":"traceutil/trace.go:171","msg":"trace[1782668190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1421; }","duration":"183.660232ms","start":"2026-06-24T17:16:47.852159Z","end":"2026-06-24T17:16:48.035819Z","steps":["trace[1782668190] 'agreement among raft nodes before linearized reading' (duration: 183.55161ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:16:48.035878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.233661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T17:16:48.035933Z","caller":"traceutil/trace.go:171","msg":"trace[1943876778] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1421; }","duration":"162.328493ms","start":"2026-06-24T17:16:47.87359Z","end":"2026-06-24T17:16:48.035918Z","steps":["trace[1943876778] 'agreement among raft nodes before linearized reading' (duration: 162.238481ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:16:48.036019Z","caller":"traceutil/trace.go:171","msg":"trace[1558566830] transaction","detail":"{read_only:false; response_revision:1421; number_of_response:1; }","duration":"212.949616ms","start":"2026-06-24T17:16:47.823054Z","end":"2026-06-24T17:16:48.036004Z","steps":["trace[1558566830] 'process raft request' (duration: 212.427873ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:17:34.446524Z","caller":"traceutil/trace.go:171","msg":"trace[522359972] linearizableReadLoop","detail":"{readStateIndex:1697; appliedIndex:1696; }","duration":"124.291859ms","start":"2026-06-24T17:17:34.322211Z","end":"2026-06-24T17:17:34.446503Z","steps":["trace[522359972] 'read index received' (duration: 98.797458ms)","trace[522359972] 'applied index is now lower than readState.Index' (duration: 25.49166ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:17:34.446538Z","caller":"traceutil/trace.go:171","msg":"trace[1684526660] transaction","detail":"{read_only:false; response_revision:1631; number_of_response:1; }","duration":"122.612017ms","start":"2026-06-24T17:17:34.323912Z","end":"2026-06-24T17:17:34.446524Z","steps":["trace[1684526660] 'process raft request' (duration: 122.483044ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:17:34.446501Z","caller":"traceutil/trace.go:171","msg":"trace[1878432288] transaction","detail":"{read_only:false; response_revision:1632; number_of_response:1; }","duration":"122.035944ms","start":"2026-06-24T17:17:34.324442Z","end":"2026-06-24T17:17:34.446478Z","steps":["trace[1878432288] 'process raft request' (duration: 121.993833ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:17:34.446452Z","caller":"traceutil/trace.go:171","msg":"trace[1233116132] transaction","detail":"{read_only:false; response_revision:1630; number_of_response:1; }","duration":"124.973164ms","start":"2026-06-24T17:17:34.321444Z","end":"2026-06-24T17:17:34.446417Z","steps":["trace[1233116132] 'process raft request' (duration: 99.485554ms)","trace[1233116132] 'compare' (duration: 25.345377ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:17:34.446764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.532754ms","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-24T17:17:34.447144Z","caller":"traceutil/trace.go:171","msg":"trace[958208953] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1632; }","duration":"124.940884ms","start":"2026-06-24T17:17:34.322187Z","end":"2026-06-24T17:17:34.447128Z","steps":["trace[958208953] 'agreement among raft nodes before linearized reading' (duration: 124.437752ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:17:48.635844Z","caller":"traceutil/trace.go:171","msg":"trace[1252426749] linearizableReadLoop","detail":"{readStateIndex:1763; appliedIndex:1762; }","duration":"190.336118ms","start":"2026-06-24T17:17:48.445475Z","end":"2026-06-24T17:17:48.635811Z","steps":["trace[1252426749] 'read index received' (duration: 190.133753ms)","trace[1252426749] 'applied index is now lower than readState.Index' (duration: 200.475µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:17:48.635905Z","caller":"traceutil/trace.go:171","msg":"trace[858914902] transaction","detail":"{read_only:false; response_revision:1693; number_of_response:1; }","duration":"241.107944ms","start":"2026-06-24T17:17:48.394762Z","end":"2026-06-24T17:17:48.63587Z","steps":["trace[858914902] 'process raft request' (duration: 240.908119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:17:48.636143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.646415ms","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-24T17:17:48.636209Z","caller":"traceutil/trace.go:171","msg":"trace[724655706] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1693; }","duration":"190.726087ms","start":"2026-06-24T17:17:48.445465Z","end":"2026-06-24T17:17:48.636191Z","steps":["trace[724655706] 'agreement among raft nodes before linearized reading' (duration: 190.516762ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:07.011617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.620379ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T17:18:07.011702Z","caller":"traceutil/trace.go:171","msg":"trace[1881392646] linearizableReadLoop","detail":"{readStateIndex:1849; appliedIndex:1848; }","duration":"187.648544ms","start":"2026-06-24T17:18:06.82404Z","end":"2026-06-24T17:18:07.011688Z","steps":["trace[1881392646] 'read index received' (duration: 65.861631ms)","trace[1881392646] 'applied index is now lower than readState.Index' (duration: 121.785933ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T17:18:07.011761Z","caller":"traceutil/trace.go:171","msg":"trace[286808907] transaction","detail":"{read_only:false; response_revision:1776; number_of_response:1; }","duration":"211.983852ms","start":"2026-06-24T17:18:06.799748Z","end":"2026-06-24T17:18:07.011732Z","steps":["trace[286808907] 'process raft request' (duration: 90.178889ms)","trace[286808907] 'compare' (duration: 121.507186ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T17:18:07.011837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.797017ms","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-24T17:18:07.011859Z","caller":"traceutil/trace.go:171","msg":"trace[267017866] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1776; }","duration":"187.852399ms","start":"2026-06-24T17:18:06.824Z","end":"2026-06-24T17:18:07.011852Z","steps":["trace[267017866] 'agreement among raft nodes before linearized reading' (duration: 187.757616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:07.011914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.897073ms","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-24T17:18:07.011993Z","caller":"traceutil/trace.go:171","msg":"trace[633250208] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1776; }","duration":"183.998816ms","start":"2026-06-24T17:18:06.827987Z","end":"2026-06-24T17:18:07.011986Z","steps":["trace[633250208] 'agreement among raft nodes before linearized reading' (duration: 183.882043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:07.012076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.039137ms","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-24T17:18:07.012164Z","caller":"traceutil/trace.go:171","msg":"trace[73825758] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1776; }","duration":"184.086708ms","start":"2026-06-24T17:18:06.828009Z","end":"2026-06-24T17:18:07.012096Z","steps":["trace[73825758] 'agreement among raft nodes before linearized reading' (duration: 183.938344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:18:07.012186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.136769ms","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-24T17:18:07.012221Z","caller":"traceutil/trace.go:171","msg":"trace[1410963295] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1776; }","duration":"184.19302ms","start":"2026-06-24T17:18:06.82802Z","end":"2026-06-24T17:18:07.012213Z","steps":["trace[1410963295] 'agreement among raft nodes before linearized reading' (duration: 184.018756ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:19:23.044522Z","caller":"traceutil/trace.go:171","msg":"trace[1685793662] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"145.442231ms","start":"2026-06-24T17:19:22.899053Z","end":"2026-06-24T17:19:23.044495Z","steps":["trace[1685793662] 'process raft request' (duration: 145.289277ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:20:19.291075Z","caller":"traceutil/trace.go:171","msg":"trace[339219154] transaction","detail":"{read_only:false; response_revision:2401; number_of_response:1; }","duration":"102.438994ms","start":"2026-06-24T17:20:19.188609Z","end":"2026-06-24T17:20:19.291048Z","steps":["trace[339219154] 'process raft request' (duration: 102.25734ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:20:29.024837Z","caller":"traceutil/trace.go:171","msg":"trace[208986121] transaction","detail":"{read_only:false; response_revision:2451; number_of_response:1; }","duration":"117.153679ms","start":"2026-06-24T17:20:28.90766Z","end":"2026-06-24T17:20:29.024814Z","steps":["trace[208986121] 'process raft request' (duration: 116.976105ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T17:20:35.371481Z","caller":"traceutil/trace.go:171","msg":"trace[882817813] transaction","detail":"{read_only:false; response_revision:2483; number_of_response:1; }","duration":"329.455949ms","start":"2026-06-24T17:20:35.042001Z","end":"2026-06-24T17:20:35.371457Z","steps":["trace[882817813] 'process raft request' (duration: 329.320326ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T17:20:35.371621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T17:20:35.041958Z","time spent":"329.589432ms","remote":"127.0.0.1:46988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}