{"level":"warn","ts":"2026-05-26T05:59:56.895356Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T05:59:56.895441Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.3: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.3:2380","--initial-cluster=instance=https://199.204.45.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.3:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-26T05:59:56.895509Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T05:59:56.895518Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-05-26T05:59:56.895537Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-26T05:59:56.896113Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"]} {"level":"info","ts":"2026-05-26T05:59:56.896176Z","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.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.3:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-26T05:59:56.901055Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.676451ms"} {"level":"info","ts":"2026-05-26T05:59:56.907961Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"597401b06ce1cf3d","cluster-id":"dfc54657ad8a2432"} {"level":"info","ts":"2026-05-26T05:59:56.908079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=()"} {"level":"info","ts":"2026-05-26T05:59:56.908099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 0"} {"level":"info","ts":"2026-05-26T05:59:56.908111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 597401b06ce1cf3d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-26T05:59:56.908123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 1"} {"level":"info","ts":"2026-05-26T05:59:56.908159Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"warn","ts":"2026-05-26T05:59:56.91573Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-26T05:59:56.917865Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-26T05:59:56.921932Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-26T05:59:56.924473Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"597401b06ce1cf3d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-26T05:59:56.925256Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"597401b06ce1cf3d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-26T05:59:56.927538Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-26T05:59:56.927804Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-26T05:59:56.927865Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-26T05:59:56.928363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"info","ts":"2026-05-26T05:59:56.929997Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","added-peer-id":"597401b06ce1cf3d","added-peer-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-05-26T05:59:56.933441Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-26T05:59:56.933569Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-05-26T05:59:56.933623Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-05-26T05:59:56.933725Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"597401b06ce1cf3d","initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-26T05:59:56.933781Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-26T05:59:57.008711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d is starting a new election at term 1"} {"level":"info","ts":"2026-05-26T05:59:57.008798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became pre-candidate at term 1"} {"level":"info","ts":"2026-05-26T05:59:57.008823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgPreVoteResp from 597401b06ce1cf3d at term 1"} {"level":"info","ts":"2026-05-26T05:59:57.008844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became candidate at term 2"} {"level":"info","ts":"2026-05-26T05:59:57.008856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgVoteResp from 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-05-26T05:59:57.00888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became leader at term 2"} {"level":"info","ts":"2026-05-26T05:59:57.008895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 597401b06ce1cf3d elected leader 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-05-26T05:59:57.009889Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:59:57.01075Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T05:59:57.010739Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"597401b06ce1cf3d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.3:2379]}","request-path":"/0/members/597401b06ce1cf3d/attributes","cluster-id":"dfc54657ad8a2432","publish-timeout":"7s"} {"level":"info","ts":"2026-05-26T05:59:57.010896Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T05:59:57.011092Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-26T05:59:57.011119Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-26T05:59:57.011325Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:59:57.011571Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:59:57.011662Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:59:57.014717Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.3:2379"} {"level":"info","ts":"2026-05-26T05:59:57.014886Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-26T06:00:03.681099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.45829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T06:00:03.682924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.004749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-26T06:00:03.683297Z","caller":"traceutil/trace.go:171","msg":"trace[302483204] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:315; }","duration":"263.380151ms","start":"2026-05-26T06:00:03.419872Z","end":"2026-05-26T06:00:03.683252Z","steps":["trace[302483204] 'range keys from in-memory index tree' (duration: 262.851424ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:00:03.681733Z","caller":"traceutil/trace.go:171","msg":"trace[2137945007] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:0; response_revision:315; }","duration":"516.671697ms","start":"2026-05-26T06:00:03.164531Z","end":"2026-05-26T06:00:03.681203Z","steps":["trace[2137945007] 'range keys from in-memory index tree' (duration: 516.378958ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:03.683442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:03.164513Z","time spent":"518.908359ms","remote":"127.0.0.1:41004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" "} {"level":"info","ts":"2026-05-26T06:00:04.226371Z","caller":"traceutil/trace.go:171","msg":"trace[766023324] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"537.24342ms","start":"2026-05-26T06:00:03.689099Z","end":"2026-05-26T06:00:04.226343Z","steps":["trace[766023324] 'process raft request' (duration: 537.058424ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:04.226974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:03.689084Z","time spent":"537.363634ms","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T06:00:05.16087Z","caller":"traceutil/trace.go:171","msg":"trace[2040835473] linearizableReadLoop","detail":"{readStateIndex:329; appliedIndex:327; }","duration":"1.325896526s","start":"2026-05-26T06:00:03.834942Z","end":"2026-05-26T06:00:05.160839Z","steps":["trace[2040835473] 'read index received' (duration: 391.238364ms)","trace[2040835473] 'applied index is now lower than readState.Index' (duration: 934.656832ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:00:05.161018Z","caller":"traceutil/trace.go:171","msg":"trace[1713642537] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"1.470471347s","start":"2026-05-26T06:00:03.690533Z","end":"2026-05-26T06:00:05.161004Z","steps":["trace[1713642537] 'process raft request' (duration: 1.424507465s)","trace[1713642537] 'compare' (duration: 45.643841ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:00:05.161124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:03.690521Z","time spent":"1.470537559s","remote":"127.0.0.1:41004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T06:00:05.161149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.242047633s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-26T06:00:05.16124Z","caller":"traceutil/trace.go:171","msg":"trace[1450628795] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:317; }","duration":"1.242174447s","start":"2026-05-26T06:00:03.919047Z","end":"2026-05-26T06:00:05.161221Z","steps":["trace[1450628795] 'agreement among raft nodes before linearized reading' (duration: 1.241987451s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:05.161295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:03.919027Z","time spent":"1.24225198s","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-26T06:00:05.161549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.990235ms","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-05-26T06:00:05.161653Z","caller":"traceutil/trace.go:171","msg":"trace[2097536286] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:317; }","duration":"306.071428ms","start":"2026-05-26T06:00:04.855515Z","end":"2026-05-26T06:00:05.161587Z","steps":["trace[2097536286] 'agreement among raft nodes before linearized reading' (duration: 305.980135ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:05.161692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.326741023s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-26T06:00:05.161769Z","caller":"traceutil/trace.go:171","msg":"trace[1158072361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:317; }","duration":"1.326861597s","start":"2026-05-26T06:00:03.834889Z","end":"2026-05-26T06:00:05.161751Z","steps":["trace[1158072361] 'agreement among raft nodes before linearized reading' (duration: 1.326700792s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:05.161822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:03.834871Z","time spent":"1.32693904s","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T06:00:05.16171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:04.855496Z","time spent":"306.195692ms","remote":"127.0.0.1:41070","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-05-26T06:00:24.612983Z","caller":"traceutil/trace.go:171","msg":"trace[788761334] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"530.522901ms","start":"2026-05-26T06:00:24.082433Z","end":"2026-05-26T06:00:24.612956Z","steps":["trace[788761334] 'process raft request' (duration: 530.389287ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:24.613125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:24.082415Z","time spent":"530.645816ms","remote":"127.0.0.1:40868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T06:00:24.622859Z","caller":"traceutil/trace.go:171","msg":"trace[1249638523] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:516; }","duration":"313.936679ms","start":"2026-05-26T06:00:24.308886Z","end":"2026-05-26T06:00:24.622823Z","steps":["trace[1249638523] 'read index received' (duration: 304.160494ms)","trace[1249638523] 'applied index is now lower than readState.Index' (duration: 9.775425ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:00:24.622971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.082214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-26T06:00:24.622992Z","caller":"traceutil/trace.go:171","msg":"trace[1452736257] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:511; }","duration":"314.158417ms","start":"2026-05-26T06:00:24.308827Z","end":"2026-05-26T06:00:24.622986Z","steps":["trace[1452736257] 'agreement among raft nodes before linearized reading' (duration: 314.083774ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:24.623015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:24.308807Z","time spent":"314.202338ms","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-26T06:00:24.623233Z","caller":"traceutil/trace.go:171","msg":"trace[1793047379] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"540.398909ms","start":"2026-05-26T06:00:24.082826Z","end":"2026-05-26T06:00:24.623225Z","steps":["trace[1793047379] 'process raft request' (duration: 539.518451ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:24.623281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:24.082817Z","time spent":"540.431911ms","remote":"127.0.0.1:40868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T06:00:24.623371Z","caller":"traceutil/trace.go:171","msg":"trace[423962260] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"539.355726ms","start":"2026-05-26T06:00:24.08401Z","end":"2026-05-26T06:00:24.623365Z","steps":["trace[423962260] 'process raft request' (duration: 538.439966ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:24.623397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:24.083999Z","time spent":"539.387168ms","remote":"127.0.0.1:40868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T06:00:24.623434Z","caller":"traceutil/trace.go:171","msg":"trace[108678075] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"491.811574ms","start":"2026-05-26T06:00:24.131618Z","end":"2026-05-26T06:00:24.623429Z","steps":["trace[108678075] 'process raft request' (duration: 491.048799ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:24.623453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:24.131599Z","time spent":"491.844534ms","remote":"127.0.0.1:40868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T06:00:24.623437Z","caller":"traceutil/trace.go:171","msg":"trace[1066917418] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"509.823244ms","start":"2026-05-26T06:00:24.11358Z","end":"2026-05-26T06:00:24.623403Z","steps":["trace[1066917418] 'process raft request' (duration: 509.054799ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:00:24.623491Z","caller":"traceutil/trace.go:171","msg":"trace[739049285] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"476.7978ms","start":"2026-05-26T06:00:24.146689Z","end":"2026-05-26T06:00:24.623486Z","steps":["trace[739049285] 'process raft request' (duration: 476.010304ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:24.62351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:24.14667Z","time spent":"476.83128ms","remote":"127.0.0.1:40868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T06:00:24.623556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:24.113563Z","time spent":"509.939408ms","remote":"127.0.0.1:40868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T06:00:24.623571Z","caller":"traceutil/trace.go:171","msg":"trace[512994913] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"352.333887ms","start":"2026-05-26T06:00:24.271233Z","end":"2026-05-26T06:00:24.623566Z","steps":["trace[512994913] 'process raft request' (duration: 351.550102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:24.623594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:24.271205Z","time spent":"352.379079ms","remote":"127.0.0.1:40868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T06:00:24.623602Z","caller":"traceutil/trace.go:171","msg":"trace[2066079415] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"529.947573ms","start":"2026-05-26T06:00:24.09364Z","end":"2026-05-26T06:00:24.623587Z","steps":["trace[2066079415] 'process raft request' (duration: 528.854038ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:00:24.623678Z","caller":"traceutil/trace.go:171","msg":"trace[1961676595] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"529.965064ms","start":"2026-05-26T06:00:24.093701Z","end":"2026-05-26T06:00:24.623666Z","steps":["trace[1961676595] 'process raft request' (duration: 528.821027ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:00:24.623721Z","caller":"traceutil/trace.go:171","msg":"trace[829547969] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"526.984648ms","start":"2026-05-26T06:00:24.096726Z","end":"2026-05-26T06:00:24.623711Z","steps":["trace[829547969] 'process raft request' (duration: 525.857302ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:24.623712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:24.093623Z","time spent":"530.024815ms","remote":"127.0.0.1:40868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T06:00:24.623738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:24.093697Z","time spent":"530.007265ms","remote":"127.0.0.1:40868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T06:00:24.623749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:24.096718Z","time spent":"527.019649ms","remote":"127.0.0.1:40868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T06:00:24.623834Z","caller":"traceutil/trace.go:171","msg":"trace[1110160567] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"518.614957ms","start":"2026-05-26T06:00:24.105206Z","end":"2026-05-26T06:00:24.62382Z","steps":["trace[1110160567] 'process raft request' (duration: 517.403178ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:00:24.623527Z","caller":"traceutil/trace.go:171","msg":"trace[2068198708] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"529.614373ms","start":"2026-05-26T06:00:24.093867Z","end":"2026-05-26T06:00:24.623481Z","steps":["trace[2068198708] 'process raft request' (duration: 528.680393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:24.623879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:24.105187Z","time spent":"518.6703ms","remote":"127.0.0.1:40868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T06:00:24.623894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:24.093861Z","time spent":"530.021725ms","remote":"127.0.0.1:40868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T06:00:30.76826Z","caller":"traceutil/trace.go:171","msg":"trace[1433159373] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"356.985772ms","start":"2026-05-26T06:00:30.411243Z","end":"2026-05-26T06:00:30.768229Z","steps":["trace[1433159373] 'process raft request' (duration: 356.30949ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:30.768436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:30.411223Z","time spent":"357.124356ms","remote":"127.0.0.1:40912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T06:00:30.947926Z","caller":"traceutil/trace.go:171","msg":"trace[1352845535] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"129.238285ms","start":"2026-05-26T06:00:30.818621Z","end":"2026-05-26T06:00:30.947859Z","steps":["trace[1352845535] 'process raft request' (duration: 102.77301ms)","trace[1352845535] 'compare' (duration: 26.229288ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:00:31.603507Z","caller":"traceutil/trace.go:171","msg":"trace[1225370990] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"213.071133ms","start":"2026-05-26T06:00:31.390414Z","end":"2026-05-26T06:00:31.603485Z","steps":["trace[1225370990] 'read index received' (duration: 212.3753ms)","trace[1225370990] 'applied index is now lower than readState.Index' (duration: 695.243µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:00:31.603635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.205088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-26T06:00:31.603618Z","caller":"traceutil/trace.go:171","msg":"trace[1324905680] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"240.940764ms","start":"2026-05-26T06:00:31.362608Z","end":"2026-05-26T06:00:31.603549Z","steps":["trace[1324905680] 'process raft request' (duration: 240.388556ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:31.603731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.179058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-26T06:00:31.603756Z","caller":"traceutil/trace.go:171","msg":"trace[622798898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:610; }","duration":"209.24142ms","start":"2026-05-26T06:00:31.394509Z","end":"2026-05-26T06:00:31.603751Z","steps":["trace[622798898] 'agreement among raft nodes before linearized reading' (duration: 209.171177ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:31.603794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.542003ms","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-05-26T06:00:31.603849Z","caller":"traceutil/trace.go:171","msg":"trace[2040224345] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:610; }","duration":"211.638447ms","start":"2026-05-26T06:00:31.392195Z","end":"2026-05-26T06:00:31.603834Z","steps":["trace[2040224345] 'agreement among raft nodes before linearized reading' (duration: 211.472382ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:00:31.603661Z","caller":"traceutil/trace.go:171","msg":"trace[1455907971] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:610; }","duration":"213.273149ms","start":"2026-05-26T06:00:31.390378Z","end":"2026-05-26T06:00:31.603651Z","steps":["trace[1455907971] 'agreement among raft nodes before linearized reading' (duration: 213.202457ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:00:31.743895Z","caller":"traceutil/trace.go:171","msg":"trace[1848929835] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"135.246649ms","start":"2026-05-26T06:00:31.608621Z","end":"2026-05-26T06:00:31.743868Z","steps":["trace[1848929835] 'process raft request' (duration: 135.021502ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:00:31.744238Z","caller":"traceutil/trace.go:171","msg":"trace[1484314855] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"134.823025ms","start":"2026-05-26T06:00:31.609387Z","end":"2026-05-26T06:00:31.74421Z","steps":["trace[1484314855] 'process raft request' (duration: 134.436863ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:32.957089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.069187ms","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-05-26T06:00:32.957261Z","caller":"traceutil/trace.go:171","msg":"trace[853689757] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:613; }","duration":"727.250283ms","start":"2026-05-26T06:00:32.229989Z","end":"2026-05-26T06:00:32.95724Z","steps":["trace[853689757] 'range keys from in-memory index tree' (duration: 727.044927ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:32.957374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:31.953364Z","time spent":"1.004003073s","remote":"127.0.0.1:50456","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-26T06:00:32.957818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.259582ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-26T06:00:32.958139Z","caller":"traceutil/trace.go:171","msg":"trace[581945382] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"531.936754ms","start":"2026-05-26T06:00:32.426182Z","end":"2026-05-26T06:00:32.958118Z","steps":["trace[581945382] 'process raft request' (duration: 531.768269ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:00:32.958382Z","caller":"traceutil/trace.go:171","msg":"trace[1938988376] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"1.294176927s","start":"2026-05-26T06:00:31.664157Z","end":"2026-05-26T06:00:32.958334Z","steps":["trace[1938988376] 'process raft request' (duration: 701.088408ms)","trace[1938988376] 'compare' (duration: 591.722725ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:00:32.958381Z","caller":"traceutil/trace.go:171","msg":"trace[2024732516] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:635; }","duration":"1.268065954s","start":"2026-05-26T06:00:31.690243Z","end":"2026-05-26T06:00:32.958309Z","steps":["trace[2024732516] 'read index received' (duration: 53.382014ms)","trace[2024732516] 'applied index is now lower than readState.Index' (duration: 1.2146823s)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:00:32.958501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:31.664143Z","time spent":"1.294301942s","remote":"127.0.0.1:41034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T06:00:32.95876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.268293222s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T06:00:32.958822Z","caller":"traceutil/trace.go:171","msg":"trace[1135905055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"1.26859308s","start":"2026-05-26T06:00:31.690209Z","end":"2026-05-26T06:00:32.958802Z","steps":["trace[1135905055] 'agreement among raft nodes before linearized reading' (duration: 1.268286621s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:32.958897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:31.690197Z","time spent":"1.268686624s","remote":"127.0.0.1:40828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-26T06:00:32.959268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:32.426158Z","time spent":"532.034087ms","remote":"127.0.0.1:40988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4537,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T06:00:32.959448Z","caller":"traceutil/trace.go:171","msg":"trace[505695341] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"413.333593ms","start":"2026-05-26T06:00:32.546097Z","end":"2026-05-26T06:00:32.959431Z","steps":["trace[505695341] 'process raft request' (duration: 413.112806ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:00:32.959592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:00:32.546064Z","time spent":"413.453327ms","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T06:00:32.960289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.291932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-26T06:00:32.961144Z","caller":"traceutil/trace.go:171","msg":"trace[2046545940] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:616; }","duration":"180.387127ms","start":"2026-05-26T06:00:32.780726Z","end":"2026-05-26T06:00:32.961113Z","steps":["trace[2046545940] 'agreement among raft nodes before linearized reading' (duration: 178.651011ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:00:38.198761Z","caller":"traceutil/trace.go:171","msg":"trace[167092140] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"100.491286ms","start":"2026-05-26T06:00:38.09825Z","end":"2026-05-26T06:00:38.198741Z","steps":["trace[167092140] 'process raft request' (duration: 100.289169ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:01:02.396036Z","caller":"traceutil/trace.go:171","msg":"trace[1814467807] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"511.444582ms","start":"2026-05-26T06:01:01.884568Z","end":"2026-05-26T06:01:02.396013Z","steps":["trace[1814467807] 'process raft request' (duration: 511.278176ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:01:02.396282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:01:01.884556Z","time spent":"511.641139ms","remote":"127.0.0.1:41070","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-05-26T06:01:02.692298Z","caller":"traceutil/trace.go:171","msg":"trace[1257785874] linearizableReadLoop","detail":"{readStateIndex:847; appliedIndex:845; }","duration":"697.807592ms","start":"2026-05-26T06:01:01.994466Z","end":"2026-05-26T06:01:02.692273Z","steps":["trace[1257785874] 'read index received' (duration: 401.363116ms)","trace[1257785874] 'applied index is now lower than readState.Index' (duration: 296.443396ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:01:02.69253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.18386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-26T06:01:02.692528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.04094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-xbctd\" ","response":"range_response_count:1 size:3963"} {"level":"info","ts":"2026-05-26T06:01:02.69258Z","caller":"traceutil/trace.go:171","msg":"trace[312382285] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:815; }","duration":"249.282633ms","start":"2026-05-26T06:01:02.443284Z","end":"2026-05-26T06:01:02.692567Z","steps":["trace[312382285] 'agreement among raft nodes before linearized reading' (duration: 249.130148ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:01:02.69259Z","caller":"traceutil/trace.go:171","msg":"trace[2138996273] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-xbctd; range_end:; response_count:1; response_revision:815; }","duration":"698.114062ms","start":"2026-05-26T06:01:01.994461Z","end":"2026-05-26T06:01:02.692575Z","steps":["trace[2138996273] 'agreement among raft nodes before linearized reading' (duration: 697.916186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:01:02.692624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:01:01.994422Z","time spent":"698.196115ms","remote":"127.0.0.1:40992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3986,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-xbctd\" "} {"level":"info","ts":"2026-05-26T06:01:02.692337Z","caller":"traceutil/trace.go:171","msg":"trace[1456027953] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"806.650098ms","start":"2026-05-26T06:01:01.885659Z","end":"2026-05-26T06:01:02.692309Z","steps":["trace[1456027953] 'process raft request' (duration: 748.833491ms)","trace[1456027953] 'compare' (duration: 57.445655ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:01:02.693107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:01:01.885597Z","time spent":"807.371002ms","remote":"127.0.0.1:41070","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-05-26T06:01:39.200254Z","caller":"traceutil/trace.go:171","msg":"trace[434601648] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"634.875311ms","start":"2026-05-26T06:01:38.565361Z","end":"2026-05-26T06:01:39.200237Z","steps":["trace[434601648] 'process raft request' (duration: 634.777318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:01:39.200442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:01:38.565346Z","time spent":"634.981514ms","remote":"127.0.0.1:41070","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-05-26T06:01:39.200257Z","caller":"traceutil/trace.go:171","msg":"trace[1114932404] linearizableReadLoop","detail":"{readStateIndex:1070; appliedIndex:1069; }","duration":"324.287735ms","start":"2026-05-26T06:01:38.875946Z","end":"2026-05-26T06:01:39.200233Z","steps":["trace[1114932404] 'read index received' (duration: 324.274605ms)","trace[1114932404] 'applied index is now lower than readState.Index' (duration: 11.48µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:01:39.200679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.722109ms","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-05-26T06:01:39.200774Z","caller":"traceutil/trace.go:171","msg":"trace[1377856566] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1030; }","duration":"324.858904ms","start":"2026-05-26T06:01:38.875894Z","end":"2026-05-26T06:01:39.200753Z","steps":["trace[1377856566] 'agreement among raft nodes before linearized reading' (duration: 324.379008ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:01:39.200826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:01:38.875876Z","time spent":"324.938987ms","remote":"127.0.0.1:41070","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-05-26T06:01:39.701264Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933266086904132785,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-26T06:01:39.961301Z","caller":"traceutil/trace.go:171","msg":"trace[863391303] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"775.412695ms","start":"2026-05-26T06:01:39.185862Z","end":"2026-05-26T06:01:39.961275Z","steps":["trace[863391303] 'process raft request' (duration: 714.305438ms)","trace[863391303] 'compare' (duration: 60.548369ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:01:39.962002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:01:39.185839Z","time spent":"776.073666ms","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T06:01:39.965085Z","caller":"traceutil/trace.go:171","msg":"trace[707918585] linearizableReadLoop","detail":"{readStateIndex:1072; appliedIndex:1070; }","duration":"764.567296ms","start":"2026-05-26T06:01:39.200493Z","end":"2026-05-26T06:01:39.965061Z","steps":["trace[707918585] 'read index received' (duration: 699.698058ms)","trace[707918585] 'applied index is now lower than readState.Index' (duration: 64.867958ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:01:39.965296Z","caller":"traceutil/trace.go:171","msg":"trace[707922975] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"760.567736ms","start":"2026-05-26T06:01:39.204698Z","end":"2026-05-26T06:01:39.965265Z","steps":["trace[707922975] 'process raft request' (duration: 760.205035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:01:39.965343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"998.148502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T06:01:39.965344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.853613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T06:01:39.965397Z","caller":"traceutil/trace.go:171","msg":"trace[955579210] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1032; }","duration":"998.247935ms","start":"2026-05-26T06:01:38.967134Z","end":"2026-05-26T06:01:39.965382Z","steps":["trace[955579210] 'agreement among raft nodes before linearized reading' (duration: 998.135312ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:01:39.965409Z","caller":"traceutil/trace.go:171","msg":"trace[1825424127] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1032; }","duration":"777.950987ms","start":"2026-05-26T06:01:39.187439Z","end":"2026-05-26T06:01:39.96539Z","steps":["trace[1825424127] 'agreement among raft nodes before linearized reading' (duration: 777.852083ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:01:39.965431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:01:38.967115Z","time spent":"998.308758ms","remote":"127.0.0.1:50502","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/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-26T06:01:39.965443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:01:39.187426Z","time spent":"778.007418ms","remote":"127.0.0.1:50476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-05-26T06:01:39.965443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:01:39.204683Z","time spent":"760.684941ms","remote":"127.0.0.1:41070","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-05-26T06:01:39.965511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.085839364s","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-05-26T06:01:39.965553Z","caller":"traceutil/trace.go:171","msg":"trace[1718016705] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1032; }","duration":"1.085882545s","start":"2026-05-26T06:01:38.879661Z","end":"2026-05-26T06:01:39.965543Z","steps":["trace[1718016705] 'agreement among raft nodes before linearized reading' (duration: 1.085743981s)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:01:39.965581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:01:38.879602Z","time spent":"1.085972298s","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T06:01:39.965671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.283011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T06:01:39.965701Z","caller":"traceutil/trace.go:171","msg":"trace[666852505] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1032; }","duration":"276.346444ms","start":"2026-05-26T06:01:39.689346Z","end":"2026-05-26T06:01:39.965693Z","steps":["trace[666852505] 'agreement among raft nodes before linearized reading' (duration: 276.282472ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:01:39.965718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.563927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-26T06:01:39.965795Z","caller":"traceutil/trace.go:171","msg":"trace[285922596] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1032; }","duration":"673.699071ms","start":"2026-05-26T06:01:39.292079Z","end":"2026-05-26T06:01:39.965778Z","steps":["trace[285922596] 'agreement among raft nodes before linearized reading' (duration: 673.467164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:01:39.965857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:01:39.292058Z","time spent":"673.777284ms","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-26T06:02:01.456927Z","caller":"traceutil/trace.go:171","msg":"trace[100640801] linearizableReadLoop","detail":"{readStateIndex:1148; appliedIndex:1147; }","duration":"124.382652ms","start":"2026-05-26T06:02:01.33252Z","end":"2026-05-26T06:02:01.456903Z","steps":["trace[100640801] 'read index received' (duration: 124.215617ms)","trace[100640801] 'applied index is now lower than readState.Index' (duration: 166.035µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:02:01.457038Z","caller":"traceutil/trace.go:171","msg":"trace[1506532430] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"185.677595ms","start":"2026-05-26T06:02:01.271314Z","end":"2026-05-26T06:02:01.456992Z","steps":["trace[1506532430] 'process raft request' (duration: 185.442528ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:01.457151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.618561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-26T06:02:01.457226Z","caller":"traceutil/trace.go:171","msg":"trace[1355052338] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1103; }","duration":"124.749074ms","start":"2026-05-26T06:02:01.332466Z","end":"2026-05-26T06:02:01.457215Z","steps":["trace[1355052338] 'agreement among raft nodes before linearized reading' (duration: 124.576999ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:02.395019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.253556ms","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-05-26T06:02:02.395183Z","caller":"traceutil/trace.go:171","msg":"trace[203778423] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1109; }","duration":"164.434801ms","start":"2026-05-26T06:02:02.230729Z","end":"2026-05-26T06:02:02.395164Z","steps":["trace[203778423] 'range keys from in-memory index tree' (duration: 164.235985ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:02:04.272627Z","caller":"traceutil/trace.go:171","msg":"trace[199597574] linearizableReadLoop","detail":"{readStateIndex:1156; appliedIndex:1155; }","duration":"158.997846ms","start":"2026-05-26T06:02:04.113607Z","end":"2026-05-26T06:02:04.272604Z","steps":["trace[199597574] 'read index received' (duration: 158.80687ms)","trace[199597574] 'applied index is now lower than readState.Index' (duration: 189.566µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:02:04.2727Z","caller":"traceutil/trace.go:171","msg":"trace[1082371724] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"220.413342ms","start":"2026-05-26T06:02:04.052255Z","end":"2026-05-26T06:02:04.272668Z","steps":["trace[1082371724] 'process raft request' (duration: 220.216166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:04.273006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.319326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-26T06:02:04.273342Z","caller":"traceutil/trace.go:171","msg":"trace[1507395622] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1111; }","duration":"150.682178ms","start":"2026-05-26T06:02:04.122631Z","end":"2026-05-26T06:02:04.273313Z","steps":["trace[1507395622] 'agreement among raft nodes before linearized reading' (duration: 150.255664ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:04.273032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.421989ms","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-05-26T06:02:04.274161Z","caller":"traceutil/trace.go:171","msg":"trace[612238955] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1111; }","duration":"160.582497ms","start":"2026-05-26T06:02:04.11356Z","end":"2026-05-26T06:02:04.274142Z","steps":["trace[612238955] 'agreement among raft nodes before linearized reading' (duration: 159.160751ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:04.273228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.073324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-26T06:02:04.274284Z","caller":"traceutil/trace.go:171","msg":"trace[1604646732] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1111; }","duration":"140.152149ms","start":"2026-05-26T06:02:04.134095Z","end":"2026-05-26T06:02:04.274247Z","steps":["trace[1604646732] 'agreement among raft nodes before linearized reading' (duration: 138.925389ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:04.273936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.160904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-26T06:02:04.274394Z","caller":"traceutil/trace.go:171","msg":"trace[1241187579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1111; }","duration":"151.630039ms","start":"2026-05-26T06:02:04.122748Z","end":"2026-05-26T06:02:04.274378Z","steps":["trace[1241187579] 'agreement among raft nodes before linearized reading' (duration: 150.335858ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:20.756073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:20.200401Z","time spent":"555.667783ms","remote":"127.0.0.1:40850","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-26T06:02:21.215325Z","caller":"traceutil/trace.go:171","msg":"trace[1415011009] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"458.172265ms","start":"2026-05-26T06:02:20.757132Z","end":"2026-05-26T06:02:21.215304Z","steps":["trace[1415011009] 'process raft request' (duration: 458.112633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:21.215451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:20.757111Z","time spent":"458.279608ms","remote":"127.0.0.1:40850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":116,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T06:02:21.215721Z","caller":"traceutil/trace.go:171","msg":"trace[736180208] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"893.779124ms","start":"2026-05-26T06:02:20.321929Z","end":"2026-05-26T06:02:21.215708Z","steps":["trace[736180208] 'process raft request' (duration: 874.847085ms)","trace[736180208] 'compare' (duration: 18.199066ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:02:21.215789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:20.321905Z","time spent":"893.852136ms","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T06:02:21.215902Z","caller":"traceutil/trace.go:171","msg":"trace[707459296] linearizableReadLoop","detail":"{readStateIndex:1266; appliedIndex:1264; }","duration":"862.406744ms","start":"2026-05-26T06:02:20.353486Z","end":"2026-05-26T06:02:21.215892Z","steps":["trace[707459296] 'read index received' (duration: 402.453792ms)","trace[707459296] 'applied index is now lower than readState.Index' (duration: 459.952062ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:02:21.216313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.611789ms","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-05-26T06:02:21.216341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"817.210649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-26T06:02:21.216383Z","caller":"traceutil/trace.go:171","msg":"trace[1820410235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1216; }","duration":"817.260912ms","start":"2026-05-26T06:02:20.399115Z","end":"2026-05-26T06:02:21.216376Z","steps":["trace[1820410235] 'agreement among raft nodes before linearized reading' (duration: 817.177739ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:21.216399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:20.399104Z","time spent":"817.291372ms","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T06:02:21.216419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.650769ms","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-05-26T06:02:21.216443Z","caller":"traceutil/trace.go:171","msg":"trace[1007308336] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1216; }","duration":"824.684001ms","start":"2026-05-26T06:02:20.391751Z","end":"2026-05-26T06:02:21.216435Z","steps":["trace[1007308336] 'agreement among raft nodes before linearized reading' (duration: 824.621729ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:21.216469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:20.391734Z","time spent":"824.728862ms","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-26T06:02:21.216475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.59624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T06:02:21.21657Z","caller":"traceutil/trace.go:171","msg":"trace[878056768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1216; }","duration":"527.679302ms","start":"2026-05-26T06:02:20.688841Z","end":"2026-05-26T06:02:21.216521Z","steps":["trace[878056768] 'agreement among raft nodes before linearized reading' (duration: 527.622311ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:21.216653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.60237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-26T06:02:21.21666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:20.688823Z","time spent":"527.808506ms","remote":"127.0.0.1:40828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-26T06:02:21.216354Z","caller":"traceutil/trace.go:171","msg":"trace[564198349] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1216; }","duration":"829.655371ms","start":"2026-05-26T06:02:20.386688Z","end":"2026-05-26T06:02:21.216343Z","steps":["trace[564198349] 'agreement among raft nodes before linearized reading' (duration: 829.557078ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:21.216712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:20.386629Z","time spent":"830.076624ms","remote":"127.0.0.1:41070","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-05-26T06:02:21.216803Z","caller":"traceutil/trace.go:171","msg":"trace[107665869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1216; }","duration":"863.22064ms","start":"2026-05-26T06:02:20.353454Z","end":"2026-05-26T06:02:21.216674Z","steps":["trace[107665869] 'agreement among raft nodes before linearized reading' (duration: 862.554759ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:21.216842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:20.353441Z","time spent":"863.392466ms","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-26T06:02:34.00431Z","caller":"traceutil/trace.go:171","msg":"trace[98416277] linearizableReadLoop","detail":"{readStateIndex:1314; appliedIndex:1313; }","duration":"264.377808ms","start":"2026-05-26T06:02:33.73991Z","end":"2026-05-26T06:02:34.004287Z","steps":["trace[98416277] 'read index received' (duration: 264.189932ms)","trace[98416277] 'applied index is now lower than readState.Index' (duration: 186.786µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:02:34.004641Z","caller":"traceutil/trace.go:171","msg":"trace[270780607] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"295.096857ms","start":"2026-05-26T06:02:33.709495Z","end":"2026-05-26T06:02:34.004592Z","steps":["trace[270780607] 'process raft request' (duration: 294.668393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:34.075534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.59014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T06:02:34.075643Z","caller":"traceutil/trace.go:171","msg":"trace[620693820] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1261; }","duration":"335.736575ms","start":"2026-05-26T06:02:33.739875Z","end":"2026-05-26T06:02:34.075612Z","steps":["trace[620693820] 'agreement among raft nodes before linearized reading' (duration: 264.73983ms)","trace[620693820] 'count revisions from in-memory index tree' (duration: 70.83961ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:02:34.07571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:33.739861Z","time spent":"335.830377ms","remote":"127.0.0.1:41188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"info","ts":"2026-05-26T06:02:38.304922Z","caller":"traceutil/trace.go:171","msg":"trace[402852408] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"280.353566ms","start":"2026-05-26T06:02:38.024543Z","end":"2026-05-26T06:02:38.304897Z","steps":["trace[402852408] 'process raft request' (duration: 280.202951ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:02:39.336898Z","caller":"traceutil/trace.go:171","msg":"trace[1198539046] linearizableReadLoop","detail":"{readStateIndex:1369; appliedIndex:1368; }","duration":"279.89131ms","start":"2026-05-26T06:02:39.056984Z","end":"2026-05-26T06:02:39.336875Z","steps":["trace[1198539046] 'read index received' (duration: 279.715924ms)","trace[1198539046] 'applied index is now lower than readState.Index' (duration: 174.406µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:02:39.337003Z","caller":"traceutil/trace.go:171","msg":"trace[2145212383] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"390.589516ms","start":"2026-05-26T06:02:38.946402Z","end":"2026-05-26T06:02:39.336991Z","steps":["trace[2145212383] 'process raft request' (duration: 390.331977ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:39.337099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:38.946378Z","time spent":"390.651078ms","remote":"127.0.0.1:40992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1768,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T06:02:39.337242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.23054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T06:02:39.337318Z","caller":"traceutil/trace.go:171","msg":"trace[2098561723] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1315; }","duration":"280.372566ms","start":"2026-05-26T06:02:39.056933Z","end":"2026-05-26T06:02:39.337305Z","steps":["trace[2098561723] 'agreement among raft nodes before linearized reading' (duration: 280.20349ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:39.956023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.514268ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T06:02:39.956204Z","caller":"traceutil/trace.go:171","msg":"trace[1302946928] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"665.428722ms","start":"2026-05-26T06:02:39.290741Z","end":"2026-05-26T06:02:39.95617Z","steps":["trace[1302946928] 'process raft request' (duration: 328.714168ms)","trace[1302946928] 'compare' (duration: 336.284421ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:02:39.956246Z","caller":"traceutil/trace.go:171","msg":"trace[317439701] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"614.771065ms","start":"2026-05-26T06:02:39.341454Z","end":"2026-05-26T06:02:39.956225Z","steps":["trace[317439701] 'process raft request' (duration: 614.675862ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:02:39.956252Z","caller":"traceutil/trace.go:171","msg":"trace[1285406528] linearizableReadLoop","detail":"{readStateIndex:1370; appliedIndex:1369; }","duration":"619.260559ms","start":"2026-05-26T06:02:39.336963Z","end":"2026-05-26T06:02:39.956223Z","steps":["trace[1285406528] 'read index received' (duration: 282.570796ms)","trace[1285406528] 'applied index is now lower than readState.Index' (duration: 336.686343ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:02:39.956316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:39.341434Z","time spent":"614.853767ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":656,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T06:02:39.956396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:39.290715Z","time spent":"665.590438ms","remote":"127.0.0.1:41070","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-05-26T06:02:39.95656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.408563ms","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-05-26T06:02:39.95656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.229795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1783"} {"level":"warn","ts":"2026-05-26T06:02:39.956635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.100727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-26T06:02:39.956659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.696124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T06:02:39.956677Z","caller":"traceutil/trace.go:171","msg":"trace[110716059] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1317; }","duration":"613.391321ms","start":"2026-05-26T06:02:39.343278Z","end":"2026-05-26T06:02:39.95667Z","steps":["trace[110716059] 'agreement among raft nodes before linearized reading' (duration: 613.205285ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:39.956669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.874654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T06:02:39.956691Z","caller":"traceutil/trace.go:171","msg":"trace[145507132] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1317; }","duration":"233.20373ms","start":"2026-05-26T06:02:39.723472Z","end":"2026-05-26T06:02:39.956676Z","steps":["trace[145507132] 'agreement among raft nodes before linearized reading' (duration: 233.119997ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:02:39.956688Z","caller":"traceutil/trace.go:171","msg":"trace[727572497] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1317; }","duration":"265.767026ms","start":"2026-05-26T06:02:39.690913Z","end":"2026-05-26T06:02:39.95668Z","steps":["trace[727572497] 'agreement among raft nodes before linearized reading' (duration: 265.723074ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:02:39.956731Z","caller":"traceutil/trace.go:171","msg":"trace[925730076] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1317; }","duration":"890.994928ms","start":"2026-05-26T06:02:39.065721Z","end":"2026-05-26T06:02:39.956716Z","steps":["trace[925730076] 'agreement among raft nodes before linearized reading' (duration: 890.873224ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:39.956777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:39.343258Z","time spent":"613.509695ms","remote":"127.0.0.1:40992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":1806,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "} {"level":"warn","ts":"2026-05-26T06:02:39.956783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.036475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1243"} {"level":"warn","ts":"2026-05-26T06:02:39.956785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:39.065665Z","time spent":"891.108051ms","remote":"127.0.0.1:50514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-05-26T06:02:39.956808Z","caller":"traceutil/trace.go:171","msg":"trace[732019690] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1317; }","duration":"545.083317ms","start":"2026-05-26T06:02:39.411718Z","end":"2026-05-26T06:02:39.956801Z","steps":["trace[732019690] 'agreement among raft nodes before linearized reading' (duration: 545.006454ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:39.956822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.150937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-26T06:02:39.956837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:39.411706Z","time spent":"545.124478ms","remote":"127.0.0.1:40970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":1266,"request content":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" "} {"level":"info","ts":"2026-05-26T06:02:39.956867Z","caller":"traceutil/trace.go:171","msg":"trace[1475102074] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1317; }","duration":"530.207708ms","start":"2026-05-26T06:02:39.426645Z","end":"2026-05-26T06:02:39.956853Z","steps":["trace[1475102074] 'agreement among raft nodes before linearized reading' (duration: 530.081314ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:02:39.956603Z","caller":"traceutil/trace.go:171","msg":"trace[1590904149] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1317; }","duration":"647.495686ms","start":"2026-05-26T06:02:39.309097Z","end":"2026-05-26T06:02:39.956593Z","steps":["trace[1590904149] 'agreement among raft nodes before linearized reading' (duration: 647.260999ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:39.956905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:39.426638Z","time spent":"530.255671ms","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-26T06:02:39.956924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:39.309084Z","time spent":"647.824527ms","remote":"127.0.0.1:41070","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-05-26T06:02:39.957008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.471959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-26T06:02:39.957041Z","caller":"traceutil/trace.go:171","msg":"trace[789443518] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1317; }","duration":"573.540751ms","start":"2026-05-26T06:02:39.383491Z","end":"2026-05-26T06:02:39.957031Z","steps":["trace[789443518] 'agreement among raft nodes before linearized reading' (duration: 573.447878ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:39.956942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.151017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:1 size:212"} {"level":"warn","ts":"2026-05-26T06:02:39.957072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:39.383472Z","time spent":"573.589923ms","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-26T06:02:39.957095Z","caller":"traceutil/trace.go:171","msg":"trace[1401369931] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:1; response_revision:1317; }","duration":"549.325083ms","start":"2026-05-26T06:02:39.407746Z","end":"2026-05-26T06:02:39.957071Z","steps":["trace[1401369931] 'agreement among raft nodes before linearized reading' (duration: 549.167428ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:39.957148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:39.407726Z","time spent":"549.407615ms","remote":"127.0.0.1:41004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":235,"request content":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" "} {"level":"warn","ts":"2026-05-26T06:02:39.95736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.988308ms","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-05-26T06:02:39.957399Z","caller":"traceutil/trace.go:171","msg":"trace[144793147] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1317; }","duration":"528.093821ms","start":"2026-05-26T06:02:39.429295Z","end":"2026-05-26T06:02:39.957389Z","steps":["trace[144793147] 'agreement among raft nodes before linearized reading' (duration: 527.192952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:39.957429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:39.429288Z","time spent":"528.132683ms","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-26T06:02:40.18086Z","caller":"traceutil/trace.go:171","msg":"trace[2011050761] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"217.848777ms","start":"2026-05-26T06:02:39.962987Z","end":"2026-05-26T06:02:40.180836Z","steps":["trace[2011050761] 'process raft request' (duration: 217.428324ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:02:40.18094Z","caller":"traceutil/trace.go:171","msg":"trace[2102402680] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"217.858057ms","start":"2026-05-26T06:02:39.963045Z","end":"2026-05-26T06:02:40.180903Z","steps":["trace[2102402680] 'process raft request' (duration: 217.439814ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:02:40.181093Z","caller":"traceutil/trace.go:171","msg":"trace[660497122] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"219.208911ms","start":"2026-05-26T06:02:39.961872Z","end":"2026-05-26T06:02:40.181081Z","steps":["trace[660497122] 'process raft request' (duration: 218.402805ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:02:40.181077Z","caller":"traceutil/trace.go:171","msg":"trace[3807105] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"218.012332ms","start":"2026-05-26T06:02:39.963037Z","end":"2026-05-26T06:02:40.18105Z","steps":["trace[3807105] 'process raft request' (duration: 217.414613ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:02:40.181252Z","caller":"traceutil/trace.go:171","msg":"trace[2080506765] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"214.710416ms","start":"2026-05-26T06:02:39.966529Z","end":"2026-05-26T06:02:40.18124Z","steps":["trace[2080506765] 'process raft request' (duration: 213.991613ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:02:40.459676Z","caller":"traceutil/trace.go:171","msg":"trace[486977259] linearizableReadLoop","detail":"{readStateIndex:1379; appliedIndex:1378; }","duration":"151.00524ms","start":"2026-05-26T06:02:40.308649Z","end":"2026-05-26T06:02:40.459655Z","steps":["trace[486977259] 'read index received' (duration: 106.043236ms)","trace[486977259] 'applied index is now lower than readState.Index' (duration: 44.960484ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:02:40.459864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.199996ms","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-05-26T06:02:40.459892Z","caller":"traceutil/trace.go:171","msg":"trace[2124079313] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1324; }","duration":"151.267538ms","start":"2026-05-26T06:02:40.308617Z","end":"2026-05-26T06:02:40.459885Z","steps":["trace[2124079313] 'agreement among raft nodes before linearized reading' (duration: 151.121824ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:02:40.459728Z","caller":"traceutil/trace.go:171","msg":"trace[876728357] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"189.682183ms","start":"2026-05-26T06:02:40.270003Z","end":"2026-05-26T06:02:40.459685Z","steps":["trace[876728357] 'process raft request' (duration: 144.710228ms)","trace[876728357] 'compare' (duration: 44.651004ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:02:40.978708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.5556ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-26T06:02:40.978835Z","caller":"traceutil/trace.go:171","msg":"trace[798209154] linearizableReadLoop","detail":"{readStateIndex:1381; appliedIndex:1380; }","duration":"113.843917ms","start":"2026-05-26T06:02:40.864968Z","end":"2026-05-26T06:02:40.978812Z","steps":["trace[798209154] 'read index received' (duration: 49.082µs)","trace[798209154] 'applied index is now lower than readState.Index' (duration: 113.792945ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:02:40.978971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.996242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T06:02:40.979025Z","caller":"traceutil/trace.go:171","msg":"trace[309876881] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1326; }","duration":"114.165677ms","start":"2026-05-26T06:02:40.864843Z","end":"2026-05-26T06:02:40.979008Z","steps":["trace[309876881] 'agreement among raft nodes before linearized reading' (duration: 114.030963ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:02:40.978935Z","caller":"traceutil/trace.go:171","msg":"trace[814083236] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"434.667262ms","start":"2026-05-26T06:02:40.544231Z","end":"2026-05-26T06:02:40.978899Z","steps":["trace[814083236] 'process raft request' (duration: 201.838554ms)","trace[814083236] 'compare' (duration: 232.374513ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T06:02:40.979217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:40.544213Z","time spent":"434.9518ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":885,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-26T06:02:48.385558Z","caller":"traceutil/trace.go:171","msg":"trace[2138776709] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"170.202547ms","start":"2026-05-26T06:02:48.215321Z","end":"2026-05-26T06:02:48.385524Z","steps":["trace[2138776709] 'process raft request' (duration: 140.767631ms)","trace[2138776709] 'compare' (duration: 29.212299ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:02:48.399305Z","caller":"traceutil/trace.go:171","msg":"trace[876678919] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"174.125592ms","start":"2026-05-26T06:02:48.225151Z","end":"2026-05-26T06:02:48.399276Z","steps":["trace[876678919] 'process raft request' (duration: 173.984978ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:48.600491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.204449ms","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-05-26T06:02:48.600613Z","caller":"traceutil/trace.go:171","msg":"trace[1240894778] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1395; }","duration":"105.370075ms","start":"2026-05-26T06:02:48.495227Z","end":"2026-05-26T06:02:48.600597Z","steps":["trace[1240894778] 'range keys from in-memory index tree' (duration: 105.053534ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:48.600508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.07536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-26T06:02:48.600811Z","caller":"traceutil/trace.go:171","msg":"trace[478395342] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1395; }","duration":"103.416341ms","start":"2026-05-26T06:02:48.497385Z","end":"2026-05-26T06:02:48.600801Z","steps":["trace[478395342] 'range keys from in-memory index tree' (duration: 102.882774ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:02:54.412278Z","caller":"traceutil/trace.go:171","msg":"trace[1498603307] linearizableReadLoop","detail":"{readStateIndex:1481; appliedIndex:1480; }","duration":"357.167921ms","start":"2026-05-26T06:02:54.055085Z","end":"2026-05-26T06:02:54.412253Z","steps":["trace[1498603307] 'read index received' (duration: 356.999956ms)","trace[1498603307] 'applied index is now lower than readState.Index' (duration: 166.985µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:02:54.41254Z","caller":"traceutil/trace.go:171","msg":"trace[841674129] transaction","detail":"{read_only:false; response_revision:1424; number_of_response:1; }","duration":"414.868685ms","start":"2026-05-26T06:02:53.997638Z","end":"2026-05-26T06:02:54.412507Z","steps":["trace[841674129] 'process raft request' (duration: 414.495503ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:54.412671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:53.997618Z","time spent":"414.977748ms","remote":"127.0.0.1:41070","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-05-26T06:02:54.412773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.938238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-26T06:02:54.412866Z","caller":"traceutil/trace.go:171","msg":"trace[1319151085] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1424; }","duration":"170.090762ms","start":"2026-05-26T06:02:54.242753Z","end":"2026-05-26T06:02:54.412844Z","steps":["trace[1319151085] 'agreement among raft nodes before linearized reading' (duration: 169.844534ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:54.412965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.884584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-26T06:02:54.413011Z","caller":"traceutil/trace.go:171","msg":"trace[1914504878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1424; }","duration":"357.970386ms","start":"2026-05-26T06:02:54.055029Z","end":"2026-05-26T06:02:54.412999Z","steps":["trace[1914504878] 'agreement among raft nodes before linearized reading' (duration: 357.870343ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:54.413041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:54.054932Z","time spent":"358.102031ms","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-26T06:02:54.834532Z","caller":"traceutil/trace.go:171","msg":"trace[1920391842] transaction","detail":"{read_only:false; response_revision:1425; number_of_response:1; }","duration":"417.905093ms","start":"2026-05-26T06:02:54.416603Z","end":"2026-05-26T06:02:54.834508Z","steps":["trace[1920391842] 'process raft request' (duration: 417.737158ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:54.83502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:54.416585Z","time spent":"418.239474ms","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T06:02:54.852919Z","caller":"traceutil/trace.go:171","msg":"trace[554976131] transaction","detail":"{read_only:false; response_revision:1426; number_of_response:1; }","duration":"435.798068ms","start":"2026-05-26T06:02:54.417101Z","end":"2026-05-26T06:02:54.852899Z","steps":["trace[554976131] 'process raft request' (duration: 435.673824ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:54.853083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:54.417078Z","time spent":"435.933422ms","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T06:02:54.853385Z","caller":"traceutil/trace.go:171","msg":"trace[1687968043] transaction","detail":"{read_only:false; response_revision:1427; number_of_response:1; }","duration":"436.150109ms","start":"2026-05-26T06:02:54.417217Z","end":"2026-05-26T06:02:54.853368Z","steps":["trace[1687968043] 'process raft request' (duration: 435.653403ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:54.853647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.971941ms","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-05-26T06:02:54.853704Z","caller":"traceutil/trace.go:171","msg":"trace[2032738018] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1428; }","duration":"435.070255ms","start":"2026-05-26T06:02:54.418623Z","end":"2026-05-26T06:02:54.853693Z","steps":["trace[2032738018] 'agreement among raft nodes before linearized reading' (duration: 434.898349ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:54.853728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:54.417208Z","time spent":"436.477349ms","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T06:02:54.853739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:54.418613Z","time spent":"435.117856ms","remote":"127.0.0.1:41070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-26T06:02:54.85347Z","caller":"traceutil/trace.go:171","msg":"trace[608780187] linearizableReadLoop","detail":"{readStateIndex:1485; appliedIndex:1481; }","duration":"434.788046ms","start":"2026-05-26T06:02:54.418657Z","end":"2026-05-26T06:02:54.853445Z","steps":["trace[608780187] 'read index received' (duration: 415.487976ms)","trace[608780187] 'applied index is now lower than readState.Index' (duration: 19.29895ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:02:54.853505Z","caller":"traceutil/trace.go:171","msg":"trace[1747337894] transaction","detail":"{read_only:false; response_revision:1428; number_of_response:1; }","duration":"436.229772ms","start":"2026-05-26T06:02:54.417262Z","end":"2026-05-26T06:02:54.853492Z","steps":["trace[1747337894] 'process raft request' (duration: 436.066657ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:54.853906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T06:02:54.417256Z","time spent":"436.593574ms","remote":"127.0.0.1:41070","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-05-26T06:02:54.853972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.380115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T06:02:54.854018Z","caller":"traceutil/trace.go:171","msg":"trace[2093728129] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1428; }","duration":"294.467889ms","start":"2026-05-26T06:02:54.55954Z","end":"2026-05-26T06:02:54.854008Z","steps":["trace[2093728129] 'agreement among raft nodes before linearized reading' (duration: 294.344345ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:54.854278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.833792ms","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-05-26T06:02:54.854324Z","caller":"traceutil/trace.go:171","msg":"trace[1043316849] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1428; }","duration":"224.916004ms","start":"2026-05-26T06:02:54.629397Z","end":"2026-05-26T06:02:54.854313Z","steps":["trace[1043316849] 'agreement among raft nodes before linearized reading' (duration: 224.78797ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T06:02:54.85451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.11664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-26T06:02:54.854553Z","caller":"traceutil/trace.go:171","msg":"trace[971643491] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1428; }","duration":"220.198143ms","start":"2026-05-26T06:02:54.634345Z","end":"2026-05-26T06:02:54.854543Z","steps":["trace[971643491] 'agreement among raft nodes before linearized reading' (duration: 219.776159ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T06:02:54.987283Z","caller":"traceutil/trace.go:171","msg":"trace[1135875159] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"128.449395ms","start":"2026-05-26T06:02:54.8588Z","end":"2026-05-26T06:02:54.987249Z","steps":["trace[1135875159] 'process raft request' (duration: 91.163228ms)","trace[1135875159] 'compare' (duration: 37.025549ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T06:02:54.987434Z","caller":"traceutil/trace.go:171","msg":"trace[889341603] transaction","detail":"{read_only:false; response_revision:1431; number_of_response:1; }","duration":"128.349552ms","start":"2026-05-26T06:02:54.859055Z","end":"2026-05-26T06:02:54.987404Z","steps":["trace[889341603] 'process raft request' (duration: 128.120465ms)"],"step_count":1}