{"level":"warn","ts":"2026-09-14T00:50:43.146881Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-14T00:50:43.146991Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.153: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://162.253.55.153:2380","--initial-cluster=instance=https://162.253.55.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.153: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-09-14T00:50:43.147062Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-14T00:50:43.147075Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.153:2380"]} {"level":"info","ts":"2026-09-14T00:50:43.147096Z","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-09-14T00:50:43.147762Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.153:2379"]} {"level":"info","ts":"2026-09-14T00:50:43.147848Z","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://162.253.55.153:2380"],"listen-peer-urls":["https://162.253.55.153:2380"],"advertise-client-urls":["https://162.253.55.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.153: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-09-14T00:50:43.153267Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.209531ms"} {"level":"info","ts":"2026-09-14T00:50:43.160408Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"522eb07aa35b671b","cluster-id":"49de17121e7ddda"} {"level":"info","ts":"2026-09-14T00:50:43.160472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b switched to configuration voters=()"} {"level":"info","ts":"2026-09-14T00:50:43.160489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b became follower at term 0"} {"level":"info","ts":"2026-09-14T00:50:43.160504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 522eb07aa35b671b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-14T00:50:43.160513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b became follower at term 1"} {"level":"info","ts":"2026-09-14T00:50:43.160545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b switched to configuration voters=(5921864600811955995)"} {"level":"warn","ts":"2026-09-14T00:50:43.174861Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-14T00:50:43.177935Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-14T00:50:43.179484Z","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-09-14T00:50:43.181382Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"522eb07aa35b671b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-14T00:50:43.18159Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"522eb07aa35b671b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-14T00:50:43.181747Z","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-09-14T00:50:43.181821Z","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-09-14T00:50:43.181832Z","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-09-14T00:50:43.184368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b switched to configuration voters=(5921864600811955995)"} {"level":"info","ts":"2026-09-14T00:50:43.184473Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49de17121e7ddda","local-member-id":"522eb07aa35b671b","added-peer-id":"522eb07aa35b671b","added-peer-peer-urls":["https://162.253.55.153:2380"]} {"level":"info","ts":"2026-09-14T00:50:43.185013Z","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-09-14T00:50:43.185147Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.153:2380"} {"level":"info","ts":"2026-09-14T00:50:43.185738Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.153:2380"} {"level":"info","ts":"2026-09-14T00:50:43.185223Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"522eb07aa35b671b","initial-advertise-peer-urls":["https://162.253.55.153:2380"],"listen-peer-urls":["https://162.253.55.153:2380"],"advertise-client-urls":["https://162.253.55.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-14T00:50:43.185253Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-14T00:50:43.260883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b is starting a new election at term 1"} {"level":"info","ts":"2026-09-14T00:50:43.26095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b became pre-candidate at term 1"} {"level":"info","ts":"2026-09-14T00:50:43.261001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b received MsgPreVoteResp from 522eb07aa35b671b at term 1"} {"level":"info","ts":"2026-09-14T00:50:43.261025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b became candidate at term 2"} {"level":"info","ts":"2026-09-14T00:50:43.261042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b received MsgVoteResp from 522eb07aa35b671b at term 2"} {"level":"info","ts":"2026-09-14T00:50:43.261059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b became leader at term 2"} {"level":"info","ts":"2026-09-14T00:50:43.261079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 522eb07aa35b671b elected leader 522eb07aa35b671b at term 2"} {"level":"info","ts":"2026-09-14T00:50:43.262272Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-14T00:50:43.263238Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"522eb07aa35b671b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.153:2379]}","request-path":"/0/members/522eb07aa35b671b/attributes","cluster-id":"49de17121e7ddda","publish-timeout":"7s"} {"level":"info","ts":"2026-09-14T00:50:43.263382Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-14T00:50:43.263337Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-14T00:50:43.266757Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.153:2379"} {"level":"info","ts":"2026-09-14T00:50:43.267468Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49de17121e7ddda","local-member-id":"522eb07aa35b671b","cluster-version":"3.5"} {"level":"info","ts":"2026-09-14T00:50:43.267765Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-14T00:50:43.267827Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-14T00:50:43.267877Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-14T00:50:43.267901Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-14T00:50:43.268285Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-14T00:50:53.963537Z","caller":"traceutil/trace.go:171","msg":"trace[144853672] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"178.390631ms","start":"2026-09-14T00:50:53.785125Z","end":"2026-09-14T00:50:53.963516Z","steps":["trace[144853672] 'process raft request' (duration: 178.273427ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T00:50:54.315298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.033773ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-14T00:50:54.315405Z","caller":"traceutil/trace.go:171","msg":"trace[523238891] linearizableReadLoop","detail":"{readStateIndex:405; appliedIndex:404; }","duration":"170.88197ms","start":"2026-09-14T00:50:54.144508Z","end":"2026-09-14T00:50:54.31539Z","steps":["trace[523238891] 'read index received' (duration: 51.002µs)","trace[523238891] 'applied index is now lower than readState.Index' (duration: 170.829728ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T00:50:54.315467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.963913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-14T00:50:54.315496Z","caller":"traceutil/trace.go:171","msg":"trace[67617036] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:393; }","duration":"171.035956ms","start":"2026-09-14T00:50:54.144452Z","end":"2026-09-14T00:50:54.315488Z","steps":["trace[67617036] 'agreement among raft nodes before linearized reading' (duration: 170.977534ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T00:50:54.315603Z","caller":"traceutil/trace.go:171","msg":"trace[1687391320] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"345.13546ms","start":"2026-09-14T00:50:53.970435Z","end":"2026-09-14T00:50:54.31557Z","steps":["trace[1687391320] 'process raft request' (duration: 100.744715ms)","trace[1687391320] 'compare' (duration: 242.212323ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T00:50:54.315764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T00:50:53.97041Z","time spent":"345.269355ms","remote":"127.0.0.1:59714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2903,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-14T00:51:24.626532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.712242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-14T00:51:24.626624Z","caller":"traceutil/trace.go:171","msg":"trace[1594057682] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:536; }","duration":"110.856767ms","start":"2026-09-14T00:51:24.515747Z","end":"2026-09-14T00:51:24.626603Z","steps":["trace[1594057682] 'range keys from in-memory index tree' (duration: 110.61836ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T00:51:31.11082Z","caller":"traceutil/trace.go:171","msg":"trace[588202635] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"218.901675ms","start":"2026-09-14T00:51:30.891892Z","end":"2026-09-14T00:51:31.110793Z","steps":["trace[588202635] 'process raft request' (duration: 218.71367ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T00:51:31.179412Z","caller":"traceutil/trace.go:171","msg":"trace[1873174853] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"188.893608ms","start":"2026-09-14T00:51:30.990487Z","end":"2026-09-14T00:51:31.17938Z","steps":["trace[1873174853] 'process raft request' (duration: 183.146111ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T00:51:32.011855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.321472ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-14T00:51:32.011972Z","caller":"traceutil/trace.go:171","msg":"trace[1538240133] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:668; }","duration":"381.974014ms","start":"2026-09-14T00:51:31.629979Z","end":"2026-09-14T00:51:32.011953Z","steps":["trace[1538240133] 'read index received' (duration: 78.212µs)","trace[1538240133] 'applied index is now lower than readState.Index' (duration: 381.894092ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T00:51:32.012078Z","caller":"traceutil/trace.go:171","msg":"trace[1963804956] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"760.217108ms","start":"2026-09-14T00:51:31.251845Z","end":"2026-09-14T00:51:32.012062Z","steps":["trace[1963804956] 'process raft request' (duration: 334.608018ms)","trace[1963804956] 'compare' (duration: 425.146067ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T00:51:32.012175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T00:51:31.251821Z","time spent":"760.297859ms","remote":"127.0.0.1:59742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-14T00:51:32.012338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.094981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-14T00:51:32.012399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.90284ms","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-09-14T00:51:32.012401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.820231ms","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-09-14T00:51:32.01242Z","caller":"traceutil/trace.go:171","msg":"trace[2121328752] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"217.209414ms","start":"2026-09-14T00:51:31.795188Z","end":"2026-09-14T00:51:32.012398Z","steps":["trace[2121328752] 'agreement among raft nodes before linearized reading' (duration: 217.039209ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T00:51:32.012449Z","caller":"traceutil/trace.go:171","msg":"trace[1318107787] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:646; }","duration":"328.994583ms","start":"2026-09-14T00:51:31.683438Z","end":"2026-09-14T00:51:32.012432Z","steps":["trace[1318107787] 'agreement among raft nodes before linearized reading' (duration: 328.823718ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T00:51:32.012462Z","caller":"traceutil/trace.go:171","msg":"trace[156634403] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:646; }","duration":"352.900312ms","start":"2026-09-14T00:51:31.659542Z","end":"2026-09-14T00:51:32.012443Z","steps":["trace[156634403] 'agreement among raft nodes before linearized reading' (duration: 352.671176ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T00:51:32.0125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T00:51:31.683393Z","time spent":"329.096755ms","remote":"127.0.0.1:59510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-14T00:51:32.012518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T00:51:31.659528Z","time spent":"352.979605ms","remote":"127.0.0.1:59510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-14T00:51:32.012823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.57955ms","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-09-14T00:51:32.013081Z","caller":"traceutil/trace.go:171","msg":"trace[695464841] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:646; }","duration":"383.111563ms","start":"2026-09-14T00:51:31.629925Z","end":"2026-09-14T00:51:32.013037Z","steps":["trace[695464841] 'agreement among raft nodes before linearized reading' (duration: 382.332133ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T00:51:32.013223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T00:51:31.629906Z","time spent":"383.302399ms","remote":"127.0.0.1:59510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-14T00:51:48.375502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.981172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-09-14T00:51:48.375547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.609963ms","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-09-14T00:51:48.375629Z","caller":"traceutil/trace.go:171","msg":"trace[863415055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:806; }","duration":"271.734046ms","start":"2026-09-14T00:51:48.103878Z","end":"2026-09-14T00:51:48.375612Z","steps":["trace[863415055] 'range keys from in-memory index tree' (duration: 271.430489ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T00:51:48.375631Z","caller":"traceutil/trace.go:171","msg":"trace[313766511] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:806; }","duration":"272.161416ms","start":"2026-09-14T00:51:48.103449Z","end":"2026-09-14T00:51:48.375611Z","steps":["trace[313766511] 'range keys from in-memory index tree' (duration: 271.820029ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T00:51:48.375586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.247093ms","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-09-14T00:51:48.375789Z","caller":"traceutil/trace.go:171","msg":"trace[979828326] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:806; }","duration":"283.461679ms","start":"2026-09-14T00:51:48.09231Z","end":"2026-09-14T00:51:48.375772Z","steps":["trace[979828326] 'range keys from in-memory index tree' (duration: 283.066579ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T00:53:08.402891Z","caller":"traceutil/trace.go:171","msg":"trace[235021409] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"314.726848ms","start":"2026-09-14T00:53:08.088135Z","end":"2026-09-14T00:53:08.402862Z","steps":["trace[235021409] 'process raft request' (duration: 314.561446ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T00:53:08.403239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T00:53:08.088117Z","time spent":"314.955412ms","remote":"127.0.0.1:59510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-14T00:53:08.511143Z","caller":"traceutil/trace.go:171","msg":"trace[355005393] linearizableReadLoop","detail":"{readStateIndex:1958; appliedIndex:1956; }","duration":"253.710856ms","start":"2026-09-14T00:53:08.257403Z","end":"2026-09-14T00:53:08.511114Z","steps":["trace[355005393] 'read index received' (duration: 145.300452ms)","trace[355005393] 'applied index is now lower than readState.Index' (duration: 108.409624ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T00:53:08.511176Z","caller":"traceutil/trace.go:171","msg":"trace[160204675] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"306.252996ms","start":"2026-09-14T00:53:08.204884Z","end":"2026-09-14T00:53:08.511137Z","steps":["trace[160204675] 'process raft request' (duration: 275.317279ms)","trace[160204675] 'compare' (duration: 30.788085ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T00:53:08.511391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.316067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b61cd8c1-826a-47c2-bbf9-35cf0a6a3b62\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-09-14T00:53:08.511398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.96822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b61cd8c1-826a-47c2-bbf9-35cf0a6a3b62\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-14T00:53:08.511468Z","caller":"traceutil/trace.go:171","msg":"trace[422000513] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b61cd8c1-826a-47c2-bbf9-35cf0a6a3b62; range_end:; response_count:1; response_revision:1884; }","duration":"122.45688ms","start":"2026-09-14T00:53:08.388994Z","end":"2026-09-14T00:53:08.511451Z","steps":["trace[422000513] 'agreement among raft nodes before linearized reading' (duration: 122.264367ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T00:53:08.511463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T00:53:08.204857Z","time spent":"306.511799ms","remote":"127.0.0.1:59510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-14T00:53:08.511479Z","caller":"traceutil/trace.go:171","msg":"trace[539109148] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b61cd8c1-826a-47c2-bbf9-35cf0a6a3b62; range_end:; response_count:1; response_revision:1884; }","duration":"254.103243ms","start":"2026-09-14T00:53:08.257358Z","end":"2026-09-14T00:53:08.511461Z","steps":["trace[539109148] 'agreement among raft nodes before linearized reading' (duration: 253.874029ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T00:53:08.511455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.722388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-14T00:53:08.511613Z","caller":"traceutil/trace.go:171","msg":"trace[1537195305] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1884; }","duration":"118.949871ms","start":"2026-09-14T00:53:08.392634Z","end":"2026-09-14T00:53:08.511584Z","steps":["trace[1537195305] 'agreement among raft nodes before linearized reading' (duration: 118.657196ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T00:53:26.650529Z","caller":"traceutil/trace.go:171","msg":"trace[1715628399] transaction","detail":"{read_only:false; response_revision:2033; number_of_response:1; }","duration":"100.686783ms","start":"2026-09-14T00:53:26.549813Z","end":"2026-09-14T00:53:26.6505Z","steps":["trace[1715628399] 'process raft request' (duration: 100.460929ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T00:53:43.240938Z","caller":"traceutil/trace.go:171","msg":"trace[910834457] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"135.808137ms","start":"2026-09-14T00:53:43.105102Z","end":"2026-09-14T00:53:43.24091Z","steps":["trace[910834457] 'process raft request' (duration: 101.568206ms)","trace[910834457] 'compare' (duration: 34.109999ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T00:53:43.241031Z","caller":"traceutil/trace.go:171","msg":"trace[1515637938] linearizableReadLoop","detail":"{readStateIndex:2218; appliedIndex:2216; }","duration":"105.980474ms","start":"2026-09-14T00:53:43.135034Z","end":"2026-09-14T00:53:43.241014Z","steps":["trace[1515637938] 'read index received' (duration: 71.648472ms)","trace[1515637938] 'applied index is now lower than readState.Index' (duration: 34.330842ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T00:53:43.241393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.33924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-14T00:53:43.241438Z","caller":"traceutil/trace.go:171","msg":"trace[500108646] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2137; }","duration":"106.42226ms","start":"2026-09-14T00:53:43.135002Z","end":"2026-09-14T00:53:43.241424Z","steps":["trace[500108646] 'agreement among raft nodes before linearized reading' (duration: 106.072345ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T00:53:43.241653Z","caller":"traceutil/trace.go:171","msg":"trace[355947526] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"135.677284ms","start":"2026-09-14T00:53:43.105945Z","end":"2026-09-14T00:53:43.241622Z","steps":["trace[355947526] 'process raft request' (duration: 134.926173ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T00:53:43.882363Z","caller":"traceutil/trace.go:171","msg":"trace[509581171] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"102.040313ms","start":"2026-09-14T00:53:43.780095Z","end":"2026-09-14T00:53:43.882135Z","steps":["trace[509581171] 'process raft request' (duration: 101.859791ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T00:56:11.731996Z","caller":"traceutil/trace.go:171","msg":"trace[584544502] transaction","detail":"{read_only:false; response_revision:3025; number_of_response:1; }","duration":"130.662983ms","start":"2026-09-14T00:56:11.601304Z","end":"2026-09-14T00:56:11.731967Z","steps":["trace[584544502] 'process raft request' (duration: 130.442426ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T00:56:12.129852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.025325ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-14T00:56:12.129949Z","caller":"traceutil/trace.go:171","msg":"trace[1543659575] linearizableReadLoop","detail":"{readStateIndex:3139; appliedIndex:3138; }","duration":"335.69618ms","start":"2026-09-14T00:56:11.794237Z","end":"2026-09-14T00:56:12.129933Z","steps":["trace[1543659575] 'read index received' (duration: 49.493038ms)","trace[1543659575] 'applied index is now lower than readState.Index' (duration: 286.202132ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T00:56:12.130407Z","caller":"traceutil/trace.go:171","msg":"trace[1498371386] transaction","detail":"{read_only:false; response_revision:3026; number_of_response:1; }","duration":"527.22315ms","start":"2026-09-14T00:56:11.603148Z","end":"2026-09-14T00:56:12.130371Z","steps":["trace[1498371386] 'process raft request' (duration: 240.566832ms)","trace[1498371386] 'compare' (duration: 285.913471ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T00:56:12.130447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.192458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-14T00:56:12.130511Z","caller":"traceutil/trace.go:171","msg":"trace[838611260] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3026; }","duration":"336.307722ms","start":"2026-09-14T00:56:11.794186Z","end":"2026-09-14T00:56:12.130494Z","steps":["trace[838611260] 'agreement among raft nodes before linearized reading' (duration: 336.184208ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T00:56:12.130554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T00:56:11.794163Z","time spent":"336.380305ms","remote":"127.0.0.1:59212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-14T00:56:12.130577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T00:56:11.603129Z","time spent":"527.360824ms","remote":"127.0.0.1:59510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-14T00:56:12.144388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.350885ms","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-09-14T00:56:12.144457Z","caller":"traceutil/trace.go:171","msg":"trace[370657313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3027; }","duration":"132.449999ms","start":"2026-09-14T00:56:12.011991Z","end":"2026-09-14T00:56:12.144441Z","steps":["trace[370657313] 'agreement among raft nodes before linearized reading' (duration: 132.251982ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T00:56:12.144436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.895627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-14T00:56:12.144526Z","caller":"traceutil/trace.go:171","msg":"trace[35454064] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3027; }","duration":"279.045833ms","start":"2026-09-14T00:56:11.865457Z","end":"2026-09-14T00:56:12.144503Z","steps":["trace[35454064] 'agreement among raft nodes before linearized reading' (duration: 278.810424ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T00:56:12.144749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.311924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-14T00:56:12.144825Z","caller":"traceutil/trace.go:171","msg":"trace[425276232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3027; }","duration":"161.405437ms","start":"2026-09-14T00:56:11.983404Z","end":"2026-09-14T00:56:12.144809Z","steps":["trace[425276232] 'agreement among raft nodes before linearized reading' (duration: 161.256152ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T00:56:12.144959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.211299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-14T00:56:12.145089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.06168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-14T00:56:12.145104Z","caller":"traceutil/trace.go:171","msg":"trace[566990797] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:3027; }","duration":"343.430186ms","start":"2026-09-14T00:56:11.80166Z","end":"2026-09-14T00:56:12.14509Z","steps":["trace[566990797] 'agreement among raft nodes before linearized reading' (duration: 343.199618ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T00:56:12.145175Z","caller":"traceutil/trace.go:171","msg":"trace[1047412996] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3027; }","duration":"187.137322ms","start":"2026-09-14T00:56:11.957981Z","end":"2026-09-14T00:56:12.145119Z","steps":["trace[1047412996] 'agreement among raft nodes before linearized reading' (duration: 187.039559ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T00:56:12.145178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-14T00:56:11.801642Z","time spent":"343.52353ms","remote":"127.0.0.1:48572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true "} {"level":"info","ts":"2026-09-14T01:00:37.449654Z","caller":"traceutil/trace.go:171","msg":"trace[1394442304] transaction","detail":"{read_only:false; response_revision:4984; number_of_response:1; }","duration":"120.073351ms","start":"2026-09-14T01:00:37.329561Z","end":"2026-09-14T01:00:37.449634Z","steps":["trace[1394442304] 'process raft request' (duration: 119.953888ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:00:37.457395Z","caller":"traceutil/trace.go:171","msg":"trace[1050634361] transaction","detail":"{read_only:false; response_revision:4985; number_of_response:1; }","duration":"127.723001ms","start":"2026-09-14T01:00:37.32965Z","end":"2026-09-14T01:00:37.457373Z","steps":["trace[1050634361] 'process raft request' (duration: 127.546727ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:00:37.457484Z","caller":"traceutil/trace.go:171","msg":"trace[143546569] linearizableReadLoop","detail":"{readStateIndex:5179; appliedIndex:5175; }","duration":"120.126712ms","start":"2026-09-14T01:00:37.337347Z","end":"2026-09-14T01:00:37.457473Z","steps":["trace[143546569] 'read index received' (duration: 112.234657ms)","trace[143546569] 'applied index is now lower than readState.Index' (duration: 7.891085ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T01:00:37.45749Z","caller":"traceutil/trace.go:171","msg":"trace[798684883] transaction","detail":"{read_only:false; response_revision:4986; number_of_response:1; }","duration":"126.236172ms","start":"2026-09-14T01:00:37.331217Z","end":"2026-09-14T01:00:37.457453Z","steps":["trace[798684883] 'process raft request' (duration: 126.080619ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T01:00:37.457602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.239754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-09-14T01:00:37.457635Z","caller":"traceutil/trace.go:171","msg":"trace[1050672557] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4989; }","duration":"120.317116ms","start":"2026-09-14T01:00:37.337309Z","end":"2026-09-14T01:00:37.457626Z","steps":["trace[1050672557] 'agreement among raft nodes before linearized reading' (duration: 120.196143ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:00:37.457738Z","caller":"traceutil/trace.go:171","msg":"trace[1288525248] transaction","detail":"{read_only:false; response_revision:4988; number_of_response:1; }","duration":"109.821719ms","start":"2026-09-14T01:00:37.347908Z","end":"2026-09-14T01:00:37.45773Z","steps":["trace[1288525248] 'process raft request' (duration: 109.492152ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:00:37.457933Z","caller":"traceutil/trace.go:171","msg":"trace[1551719074] transaction","detail":"{read_only:false; response_revision:4987; number_of_response:1; }","duration":"125.145111ms","start":"2026-09-14T01:00:37.332777Z","end":"2026-09-14T01:00:37.457923Z","steps":["trace[1551719074] 'process raft request' (duration: 124.564319ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:00:43.536226Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2879} {"level":"info","ts":"2026-09-14T01:00:43.619474Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2879,"took":"82.131185ms","hash":1855294493,"current-db-size-bytes":51949568,"current-db-size":"52 MB","current-db-size-in-use-bytes":26632192,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-14T01:00:43.619536Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1855294493,"revision":2879,"compact-revision":-1} {"level":"info","ts":"2026-09-14T01:00:50.916234Z","caller":"traceutil/trace.go:171","msg":"trace[1327450541] transaction","detail":"{read_only:false; response_revision:5198; number_of_response:1; }","duration":"266.47813ms","start":"2026-09-14T01:00:50.649734Z","end":"2026-09-14T01:00:50.916212Z","steps":["trace[1327450541] 'process raft request' (duration: 254.827703ms)","trace[1327450541] 'compare' (duration: 11.344191ms)"],"step_count":2} {"level":"warn","ts":"2026-09-14T01:00:50.916478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.246979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-14T01:00:50.91653Z","caller":"traceutil/trace.go:171","msg":"trace[1754655261] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5198; }","duration":"261.33938ms","start":"2026-09-14T01:00:50.655173Z","end":"2026-09-14T01:00:50.916513Z","steps":["trace[1754655261] 'agreement among raft nodes before linearized reading' (duration: 261.182227ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:00:50.91606Z","caller":"traceutil/trace.go:171","msg":"trace[932505309] linearizableReadLoop","detail":"{readStateIndex:5398; appliedIndex:5396; }","duration":"260.81619ms","start":"2026-09-14T01:00:50.655217Z","end":"2026-09-14T01:00:50.916033Z","steps":["trace[932505309] 'read index received' (duration: 62.323332ms)","trace[932505309] 'applied index is now lower than readState.Index' (duration: 198.491458ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T01:00:50.934643Z","caller":"traceutil/trace.go:171","msg":"trace[587027863] transaction","detail":"{read_only:false; response_revision:5199; number_of_response:1; }","duration":"177.135762ms","start":"2026-09-14T01:00:50.757481Z","end":"2026-09-14T01:00:50.934617Z","steps":["trace[587027863] 'process raft request' (duration: 176.978599ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T01:00:50.934723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.96834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-14T01:00:50.934779Z","caller":"traceutil/trace.go:171","msg":"trace[765880852] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5199; }","duration":"141.075731ms","start":"2026-09-14T01:00:50.793688Z","end":"2026-09-14T01:00:50.934764Z","steps":["trace[765880852] 'agreement among raft nodes before linearized reading' (duration: 140.973499ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:00:51.207866Z","caller":"traceutil/trace.go:171","msg":"trace[564394309] transaction","detail":"{read_only:false; response_revision:5206; number_of_response:1; }","duration":"103.161903ms","start":"2026-09-14T01:00:51.104673Z","end":"2026-09-14T01:00:51.207835Z","steps":["trace[564394309] 'process raft request' (duration: 85.086632ms)","trace[564394309] 'compare' (duration: 17.719404ms)"],"step_count":2} {"level":"info","ts":"2026-09-14T01:00:51.445232Z","caller":"traceutil/trace.go:171","msg":"trace[1563025678] linearizableReadLoop","detail":"{readStateIndex:5410; appliedIndex:5409; }","duration":"150.762848ms","start":"2026-09-14T01:00:51.294442Z","end":"2026-09-14T01:00:51.445205Z","steps":["trace[1563025678] 'read index received' (duration: 150.600265ms)","trace[1563025678] 'applied index is now lower than readState.Index' (duration: 161.353µs)"],"step_count":2} {"level":"info","ts":"2026-09-14T01:00:51.445277Z","caller":"traceutil/trace.go:171","msg":"trace[1221151253] transaction","detail":"{read_only:false; response_revision:5210; number_of_response:1; }","duration":"164.080186ms","start":"2026-09-14T01:00:51.281172Z","end":"2026-09-14T01:00:51.445252Z","steps":["trace[1221151253] 'process raft request' (duration: 163.859002ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T01:00:51.445495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.038893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-09-14T01:00:51.445539Z","caller":"traceutil/trace.go:171","msg":"trace[1288003704] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5210; }","duration":"151.128025ms","start":"2026-09-14T01:00:51.294399Z","end":"2026-09-14T01:00:51.445527Z","steps":["trace[1288003704] 'agreement among raft nodes before linearized reading' (duration: 150.911751ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:00:51.567719Z","caller":"traceutil/trace.go:171","msg":"trace[439149387] linearizableReadLoop","detail":"{readStateIndex:5412; appliedIndex:5410; }","duration":"117.634045ms","start":"2026-09-14T01:00:51.45006Z","end":"2026-09-14T01:00:51.567694Z","steps":["trace[439149387] 'read index received' (duration: 117.071934ms)","trace[439149387] 'applied index is now lower than readState.Index' (duration: 561.171µs)"],"step_count":2} {"level":"info","ts":"2026-09-14T01:00:51.567906Z","caller":"traceutil/trace.go:171","msg":"trace[893193338] transaction","detail":"{read_only:false; response_revision:5212; number_of_response:1; }","duration":"204.41319ms","start":"2026-09-14T01:00:51.363465Z","end":"2026-09-14T01:00:51.567879Z","steps":["trace[893193338] 'process raft request' (duration: 204.172885ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:00:51.567998Z","caller":"traceutil/trace.go:171","msg":"trace[674307120] transaction","detail":"{read_only:false; response_revision:5211; number_of_response:1; }","duration":"253.446372ms","start":"2026-09-14T01:00:51.314531Z","end":"2026-09-14T01:00:51.567978Z","steps":["trace[674307120] 'process raft request' (duration: 252.590325ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T01:00:51.568162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.075124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-09-14T01:00:51.568213Z","caller":"traceutil/trace.go:171","msg":"trace[1252293761] transaction","detail":"{read_only:false; response_revision:5214; number_of_response:1; }","duration":"117.753397ms","start":"2026-09-14T01:00:51.450441Z","end":"2026-09-14T01:00:51.568194Z","steps":["trace[1252293761] 'process raft request' (duration: 117.644515ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:00:51.568228Z","caller":"traceutil/trace.go:171","msg":"trace[1748704617] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5212; }","duration":"118.198336ms","start":"2026-09-14T01:00:51.450012Z","end":"2026-09-14T01:00:51.568211Z","steps":["trace[1748704617] 'agreement among raft nodes before linearized reading' (duration: 117.923841ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:00:51.568269Z","caller":"traceutil/trace.go:171","msg":"trace[1864309036] transaction","detail":"{read_only:false; response_revision:5213; number_of_response:1; }","duration":"117.89878ms","start":"2026-09-14T01:00:51.450357Z","end":"2026-09-14T01:00:51.568256Z","steps":["trace[1864309036] 'process raft request' (duration: 117.637885ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T01:00:51.56835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.122705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:126378"} {"level":"info","ts":"2026-09-14T01:00:51.568384Z","caller":"traceutil/trace.go:171","msg":"trace[1102102909] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:5216; }","duration":"118.205556ms","start":"2026-09-14T01:00:51.45017Z","end":"2026-09-14T01:00:51.568376Z","steps":["trace[1102102909] 'agreement among raft nodes before linearized reading' (duration: 118.033143ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:00:51.568431Z","caller":"traceutil/trace.go:171","msg":"trace[1840273638] transaction","detail":"{read_only:false; response_revision:5215; number_of_response:1; }","duration":"117.319798ms","start":"2026-09-14T01:00:51.451094Z","end":"2026-09-14T01:00:51.568414Z","steps":["trace[1840273638] 'process raft request' (duration: 117.029853ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:00:54.058982Z","caller":"traceutil/trace.go:171","msg":"trace[704387734] linearizableReadLoop","detail":"{readStateIndex:5501; appliedIndex:5500; }","duration":"158.763247ms","start":"2026-09-14T01:00:53.900193Z","end":"2026-09-14T01:00:54.058956Z","steps":["trace[704387734] 'read index received' (duration: 158.531502ms)","trace[704387734] 'applied index is now lower than readState.Index' (duration: 230.825µs)"],"step_count":2} {"level":"info","ts":"2026-09-14T01:00:54.059359Z","caller":"traceutil/trace.go:171","msg":"trace[440461991] transaction","detail":"{read_only:false; response_revision:5300; number_of_response:1; }","duration":"185.126169ms","start":"2026-09-14T01:00:53.874214Z","end":"2026-09-14T01:00:54.05934Z","steps":["trace[440461991] 'process raft request' (duration: 184.584708ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T01:00:54.059748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.529822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-14T01:00:54.059796Z","caller":"traceutil/trace.go:171","msg":"trace[967619012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5300; }","duration":"159.605714ms","start":"2026-09-14T01:00:53.900178Z","end":"2026-09-14T01:00:54.059784Z","steps":["trace[967619012] 'agreement among raft nodes before linearized reading' (duration: 159.439931ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:01:00.216533Z","caller":"traceutil/trace.go:171","msg":"trace[50771009] linearizableReadLoop","detail":"{readStateIndex:5615; appliedIndex:5614; }","duration":"115.694461ms","start":"2026-09-14T01:01:00.100811Z","end":"2026-09-14T01:01:00.216505Z","steps":["trace[50771009] 'read index received' (duration: 115.524118ms)","trace[50771009] 'applied index is now lower than readState.Index' (duration: 168.973µs)"],"step_count":2} {"level":"info","ts":"2026-09-14T01:01:00.216634Z","caller":"traceutil/trace.go:171","msg":"trace[1069868500] transaction","detail":"{read_only:false; response_revision:5411; number_of_response:1; }","duration":"128.046228ms","start":"2026-09-14T01:01:00.088557Z","end":"2026-09-14T01:01:00.216604Z","steps":["trace[1069868500] 'process raft request' (duration: 127.760333ms)"],"step_count":1} {"level":"warn","ts":"2026-09-14T01:01:00.216749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.71836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-14T01:01:00.216781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.963697ms","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-09-14T01:01:00.21683Z","caller":"traceutil/trace.go:171","msg":"trace[1313631018] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5411; }","duration":"116.052489ms","start":"2026-09-14T01:01:00.100765Z","end":"2026-09-14T01:01:00.216818Z","steps":["trace[1313631018] 'agreement among raft nodes before linearized reading' (duration: 115.885225ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:01:00.216803Z","caller":"traceutil/trace.go:171","msg":"trace[1374446669] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:5411; }","duration":"103.819422ms","start":"2026-09-14T01:01:00.112967Z","end":"2026-09-14T01:01:00.216786Z","steps":["trace[1374446669] 'agreement among raft nodes before linearized reading' (duration: 103.71182ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:01:05.01148Z","caller":"traceutil/trace.go:171","msg":"trace[541960509] linearizableReadLoop","detail":"{readStateIndex:5647; appliedIndex:5646; }","duration":"207.710573ms","start":"2026-09-14T01:01:04.803748Z","end":"2026-09-14T01:01:05.011458Z","steps":["trace[541960509] 'read index received' (duration: 207.618111ms)","trace[541960509] 'applied index is now lower than readState.Index' (duration: 91.642µs)"],"step_count":2} {"level":"warn","ts":"2026-09-14T01:01:05.011808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.034479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-feaa40cb-5167-429e-beae-d373dd182b31\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-09-14T01:01:05.011859Z","caller":"traceutil/trace.go:171","msg":"trace[1166556809] range","detail":"{range_begin:/registry/persistentvolumes/pvc-feaa40cb-5167-429e-beae-d373dd182b31; range_end:; response_count:1; response_revision:5442; }","duration":"208.124611ms","start":"2026-09-14T01:01:04.803721Z","end":"2026-09-14T01:01:05.011846Z","steps":["trace[1166556809] 'agreement among raft nodes before linearized reading' (duration: 207.896857ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:01:05.011565Z","caller":"traceutil/trace.go:171","msg":"trace[1995715943] transaction","detail":"{read_only:false; response_revision:5442; number_of_response:1; }","duration":"210.382185ms","start":"2026-09-14T01:01:04.801163Z","end":"2026-09-14T01:01:05.011545Z","steps":["trace[1995715943] 'process raft request' (duration: 210.14667ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:01:45.230532Z","caller":"traceutil/trace.go:171","msg":"trace[916086150] transaction","detail":"{read_only:false; response_revision:5785; number_of_response:1; }","duration":"104.054207ms","start":"2026-09-14T01:01:45.126449Z","end":"2026-09-14T01:01:45.230503Z","steps":["trace[916086150] 'process raft request' (duration: 103.899194ms)"],"step_count":1} {"level":"info","ts":"2026-09-14T01:05:43.543194Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5133} {"level":"info","ts":"2026-09-14T01:05:43.647116Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5133,"took":"102.733743ms","hash":685311266,"current-db-size-bytes":51949568,"current-db-size":"52 MB","current-db-size-in-use-bytes":20094976,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-09-14T01:05:43.647194Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":685311266,"revision":5133,"compact-revision":2879}