{"level":"warn","ts":"2026-09-22T02:01:56.675287Z","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-22T02:01:56.67537Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.75: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.75:2380","--initial-cluster=instance=https://162.253.55.75:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.75:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.75: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-22T02:01:56.675431Z","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-22T02:01:56.675445Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.75:2380"]} {"level":"info","ts":"2026-09-22T02:01:56.675466Z","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-22T02:01:56.676076Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.75:2379"]} {"level":"info","ts":"2026-09-22T02:01:56.676142Z","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.75:2380"],"listen-peer-urls":["https://162.253.55.75:2380"],"advertise-client-urls":["https://162.253.55.75:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.75:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.75: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-22T02:01:56.681053Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.692582ms"} {"level":"info","ts":"2026-09-22T02:01:56.693925Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"871515da6373d131","cluster-id":"1ca87f0850671e76"} {"level":"info","ts":"2026-09-22T02:01:56.694035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 switched to configuration voters=()"} {"level":"info","ts":"2026-09-22T02:01:56.694091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became follower at term 0"} {"level":"info","ts":"2026-09-22T02:01:56.694144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 871515da6373d131 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-22T02:01:56.694171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became follower at term 1"} {"level":"info","ts":"2026-09-22T02:01:56.694231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 switched to configuration voters=(9733710197346783537)"} {"level":"warn","ts":"2026-09-22T02:01:56.704306Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-22T02:01:56.705778Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-22T02:01:56.70696Z","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-22T02:01:56.708868Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"871515da6373d131","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-22T02:01:56.709067Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"871515da6373d131","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-22T02:01:56.709114Z","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-22T02:01:56.709548Z","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-22T02:01:56.709576Z","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-22T02:01:56.710256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 switched to configuration voters=(9733710197346783537)"} {"level":"info","ts":"2026-09-22T02:01:56.716605Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1ca87f0850671e76","local-member-id":"871515da6373d131","added-peer-id":"871515da6373d131","added-peer-peer-urls":["https://162.253.55.75:2380"]} {"level":"info","ts":"2026-09-22T02:01:56.717449Z","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-22T02:01:56.717571Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.75:2380"} {"level":"info","ts":"2026-09-22T02:01:56.717637Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.75:2380"} {"level":"info","ts":"2026-09-22T02:01:56.720509Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"871515da6373d131","initial-advertise-peer-urls":["https://162.253.55.75:2380"],"listen-peer-urls":["https://162.253.55.75:2380"],"advertise-client-urls":["https://162.253.55.75:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.75:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-22T02:01:56.720559Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-22T02:01:56.99459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 is starting a new election at term 1"} {"level":"info","ts":"2026-09-22T02:01:56.994647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-22T02:01:56.99468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 received MsgPreVoteResp from 871515da6373d131 at term 1"} {"level":"info","ts":"2026-09-22T02:01:56.994699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became candidate at term 2"} {"level":"info","ts":"2026-09-22T02:01:56.994715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 received MsgVoteResp from 871515da6373d131 at term 2"} {"level":"info","ts":"2026-09-22T02:01:56.99473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"871515da6373d131 became leader at term 2"} {"level":"info","ts":"2026-09-22T02:01:56.994747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 871515da6373d131 elected leader 871515da6373d131 at term 2"} {"level":"info","ts":"2026-09-22T02:01:56.995697Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T02:01:56.996642Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"871515da6373d131","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.75:2379]}","request-path":"/0/members/871515da6373d131/attributes","cluster-id":"1ca87f0850671e76","publish-timeout":"7s"} {"level":"info","ts":"2026-09-22T02:01:56.996774Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T02:01:56.996701Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T02:01:56.996998Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-22T02:01:56.9971Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-22T02:01:56.997247Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"1ca87f0850671e76","local-member-id":"871515da6373d131","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T02:01:56.997401Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T02:01:56.997454Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T02:01:56.998519Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-22T02:01:57.00251Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.75:2379"} {"level":"info","ts":"2026-09-22T02:02:05.36641Z","caller":"traceutil/trace.go:171","msg":"trace[38981841] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"104.567656ms","start":"2026-09-22T02:02:05.261819Z","end":"2026-09-22T02:02:05.366387Z","steps":["trace[38981841] 'process raft request' (duration: 97.275519ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:02:40.935308Z","caller":"traceutil/trace.go:171","msg":"trace[1934422939] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"156.061533ms","start":"2026-09-22T02:02:40.779224Z","end":"2026-09-22T02:02:40.935286Z","steps":["trace[1934422939] 'process raft request' (duration: 155.974651ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:02:40.935329Z","caller":"traceutil/trace.go:171","msg":"trace[744841028] transaction","detail":"{read_only:false; number_of_response:1; response_revision:588; }","duration":"167.051033ms","start":"2026-09-22T02:02:40.768235Z","end":"2026-09-22T02:02:40.935286Z","steps":["trace[744841028] 'process raft request' (duration: 109.113139ms)","trace[744841028] 'compare' (duration: 57.698ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:02:47.075231Z","caller":"traceutil/trace.go:171","msg":"trace[269730647] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"353.068819ms","start":"2026-09-22T02:02:46.72213Z","end":"2026-09-22T02:02:47.075199Z","steps":["trace[269730647] 'process raft request' (duration: 352.618023ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:02:47.075855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:02:46.722108Z","time spent":"353.270143ms","remote":"127.0.0.1:49606","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-09-22T02:02:47.157391Z","caller":"traceutil/trace.go:171","msg":"trace[1472653922] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"334.596826ms","start":"2026-09-22T02:02:46.822766Z","end":"2026-09-22T02:02:47.157363Z","steps":["trace[1472653922] 'process raft request' (duration: 321.001149ms)","trace[1472653922] 'compare' (duration: 13.18376ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:02:47.157606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:02:46.822738Z","time spent":"334.788788ms","remote":"127.0.0.1:49464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T02:02:47.829556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.233563ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-22T02:02:47.829679Z","caller":"traceutil/trace.go:171","msg":"trace[2102960886] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"588.878905ms","start":"2026-09-22T02:02:47.240783Z","end":"2026-09-22T02:02:47.829662Z","steps":["trace[2102960886] 'read index received' (duration: 327.081012ms)","trace[2102960886] 'applied index is now lower than readState.Index' (duration: 261.796513ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:02:47.829924Z","caller":"traceutil/trace.go:171","msg":"trace[564883968] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"601.979504ms","start":"2026-09-22T02:02:47.227794Z","end":"2026-09-22T02:02:47.829773Z","steps":["trace[564883968] 'process raft request' (duration: 340.172991ms)","trace[564883968] 'compare' (duration: 261.02603ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:02:47.830159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.641394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-22T02:02:47.83014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.350053ms","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-22T02:02:47.830209Z","caller":"traceutil/trace.go:171","msg":"trace[530788505] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"223.718805ms","start":"2026-09-22T02:02:47.606476Z","end":"2026-09-22T02:02:47.830194Z","steps":["trace[530788505] 'agreement among raft nodes before linearized reading' (duration: 223.656054ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:02:47.83023Z","caller":"traceutil/trace.go:171","msg":"trace[239580577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:645; }","duration":"589.502185ms","start":"2026-09-22T02:02:47.24071Z","end":"2026-09-22T02:02:47.830212Z","steps":["trace[239580577] 'agreement among raft nodes before linearized reading' (duration: 589.177229ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:02:47.83031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:02:47.240684Z","time spent":"589.616717ms","remote":"127.0.0.1:49606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-22T02:02:47.830377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.466904ms","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-22T02:02:47.830103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.049743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-r5fzq\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-22T02:02:47.830459Z","caller":"traceutil/trace.go:171","msg":"trace[721863780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:645; }","duration":"520.583116ms","start":"2026-09-22T02:02:47.309854Z","end":"2026-09-22T02:02:47.830437Z","steps":["trace[721863780] 'agreement among raft nodes before linearized reading' (duration: 520.369603ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:02:47.83048Z","caller":"traceutil/trace.go:171","msg":"trace[1771528710] range","detail":"{range_begin:/registry/pods/kube-system/cilium-r5fzq; range_end:; response_count:1; response_revision:645; }","duration":"573.46177ms","start":"2026-09-22T02:02:47.256989Z","end":"2026-09-22T02:02:47.830451Z","steps":["trace[1771528710] 'agreement among raft nodes before linearized reading' (duration: 572.915181ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:02:47.830523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:02:47.256946Z","time spent":"573.565852ms","remote":"127.0.0.1:49564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-r5fzq\" "} {"level":"warn","ts":"2026-09-22T02:02:47.830515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:02:47.309837Z","time spent":"520.668287ms","remote":"127.0.0.1:49606","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-09-22T02:02:47.830719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:02:47.227769Z","time spent":"602.40387ms","remote":"127.0.0.1:49820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T02:03:04.79491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.985977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-l87pt\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-09-22T02:03:04.795063Z","caller":"traceutil/trace.go:171","msg":"trace[465225641] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-l87pt; range_end:; response_count:1; response_revision:817; }","duration":"420.182599ms","start":"2026-09-22T02:03:04.374855Z","end":"2026-09-22T02:03:04.795038Z","steps":["trace[465225641] 'range keys from in-memory index tree' (duration: 419.793714ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:03:04.795113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:03:04.374835Z","time spent":"420.26644ms","remote":"127.0.0.1:49564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-l87pt\" "} {"level":"info","ts":"2026-09-22T02:03:04.935944Z","caller":"traceutil/trace.go:171","msg":"trace[1953463728] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"132.364391ms","start":"2026-09-22T02:03:04.803559Z","end":"2026-09-22T02:03:04.935923Z","steps":["trace[1953463728] 'process raft request' (duration: 132.25311ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:04:00.65619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.912012ms","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-22T02:04:00.656241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.216688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T02:04:00.656289Z","caller":"traceutil/trace.go:171","msg":"trace[1399507711] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1483; }","duration":"311.022193ms","start":"2026-09-22T02:04:00.345249Z","end":"2026-09-22T02:04:00.656271Z","steps":["trace[1399507711] 'range keys from in-memory index tree' (duration: 310.74763ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:04:00.656312Z","caller":"traceutil/trace.go:171","msg":"trace[1448474650] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1483; }","duration":"305.322318ms","start":"2026-09-22T02:04:00.350972Z","end":"2026-09-22T02:04:00.656294Z","steps":["trace[1448474650] 'count revisions from in-memory index tree' (duration: 305.130537ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:04:00.656309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.029598ms","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-22T02:04:00.656389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:04:00.350956Z","time spent":"305.420219ms","remote":"127.0.0.1:49600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"info","ts":"2026-09-22T02:04:00.656411Z","caller":"traceutil/trace.go:171","msg":"trace[825179859] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1483; }","duration":"211.196139ms","start":"2026-09-22T02:04:00.445197Z","end":"2026-09-22T02:04:00.656393Z","steps":["trace[825179859] 'range keys from in-memory index tree' (duration: 210.872556ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:04:00.656654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.040032ms","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-09-22T02:04:00.65633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:04:00.345188Z","time spent":"311.133894ms","remote":"127.0.0.1:49606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-22T02:04:00.656687Z","caller":"traceutil/trace.go:171","msg":"trace[354274437] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1483; }","duration":"176.104143ms","start":"2026-09-22T02:04:00.480575Z","end":"2026-09-22T02:04:00.656679Z","steps":["trace[354274437] 'range keys from in-memory index tree' (duration: 175.941152ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:04:00.656691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.852454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.75\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-22T02:04:00.656728Z","caller":"traceutil/trace.go:171","msg":"trace[148319014] range","detail":"{range_begin:/registry/masterleases/162.253.55.75; range_end:; response_count:1; response_revision:1483; }","duration":"388.934315ms","start":"2026-09-22T02:04:00.267781Z","end":"2026-09-22T02:04:00.656716Z","steps":["trace[148319014] 'range keys from in-memory index tree' (duration: 388.641843ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:04:00.65676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:04:00.267748Z","time spent":"389.005695ms","remote":"127.0.0.1:49392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.75\" "} {"level":"info","ts":"2026-09-22T02:04:00.806321Z","caller":"traceutil/trace.go:171","msg":"trace[1878758844] transaction","detail":"{read_only:false; response_revision:1488; number_of_response:1; }","duration":"136.173199ms","start":"2026-09-22T02:04:00.670122Z","end":"2026-09-22T02:04:00.806296Z","steps":["trace[1878758844] 'process raft request' (duration: 107.419904ms)","trace[1878758844] 'compare' (duration: 28.664064ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:04:02.86421Z","caller":"traceutil/trace.go:171","msg":"trace[1263612968] transaction","detail":"{read_only:false; response_revision:1496; number_of_response:1; }","duration":"129.654084ms","start":"2026-09-22T02:04:02.734529Z","end":"2026-09-22T02:04:02.864183Z","steps":["trace[1263612968] 'process raft request' (duration: 129.600123ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:04:02.864223Z","caller":"traceutil/trace.go:171","msg":"trace[912409450] transaction","detail":"{read_only:false; response_revision:1495; number_of_response:1; }","duration":"129.934376ms","start":"2026-09-22T02:04:02.734252Z","end":"2026-09-22T02:04:02.864187Z","steps":["trace[912409450] 'process raft request' (duration: 118.664188ms)","trace[912409450] 'compare' (duration: 11.080386ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:04:29.236836Z","caller":"traceutil/trace.go:171","msg":"trace[656115489] linearizableReadLoop","detail":"{readStateIndex:1996; appliedIndex:1995; }","duration":"157.330809ms","start":"2026-09-22T02:04:29.079477Z","end":"2026-09-22T02:04:29.236808Z","steps":["trace[656115489] 'read index received' (duration: 157.116028ms)","trace[656115489] 'applied index is now lower than readState.Index' (duration: 213.551µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:04:29.236887Z","caller":"traceutil/trace.go:171","msg":"trace[1351173415] transaction","detail":"{read_only:false; response_revision:1922; number_of_response:1; }","duration":"163.354359ms","start":"2026-09-22T02:04:29.073509Z","end":"2026-09-22T02:04:29.236863Z","steps":["trace[1351173415] 'process raft request' (duration: 163.169027ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:04:29.237085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.584541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-09-22T02:04:29.23714Z","caller":"traceutil/trace.go:171","msg":"trace[980938464] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1922; }","duration":"157.677071ms","start":"2026-09-22T02:04:29.07945Z","end":"2026-09-22T02:04:29.237127Z","steps":["trace[980938464] 'agreement among raft nodes before linearized reading' (duration: 157.50172ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:04:29.237291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.151284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T02:04:29.237406Z","caller":"traceutil/trace.go:171","msg":"trace[1423415229] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1922; }","duration":"124.274614ms","start":"2026-09-22T02:04:29.113113Z","end":"2026-09-22T02:04:29.237388Z","steps":["trace[1423415229] 'agreement among raft nodes before linearized reading' (duration: 124.050214ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:04:29.958522Z","caller":"traceutil/trace.go:171","msg":"trace[2018750219] linearizableReadLoop","detail":"{readStateIndex:1998; appliedIndex:1997; }","duration":"169.634861ms","start":"2026-09-22T02:04:29.788858Z","end":"2026-09-22T02:04:29.958493Z","steps":["trace[2018750219] 'read index received' (duration: 169.477099ms)","trace[2018750219] 'applied index is now lower than readState.Index' (duration: 155.932µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:04:29.958574Z","caller":"traceutil/trace.go:171","msg":"trace[1378821398] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"192.174846ms","start":"2026-09-22T02:04:29.766372Z","end":"2026-09-22T02:04:29.958547Z","steps":["trace[1378821398] 'process raft request' (duration: 191.981575ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:04:29.958866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.992333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cc444d6c-e4d3-414e-b0bb-c8284a65f3a5\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-22T02:04:29.958942Z","caller":"traceutil/trace.go:171","msg":"trace[1383837666] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cc444d6c-e4d3-414e-b0bb-c8284a65f3a5; range_end:; response_count:1; response_revision:1924; }","duration":"170.126704ms","start":"2026-09-22T02:04:29.7888Z","end":"2026-09-22T02:04:29.958927Z","steps":["trace[1383837666] 'agreement among raft nodes before linearized reading' (duration: 169.830012ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:04:30.077924Z","caller":"traceutil/trace.go:171","msg":"trace[1271385122] linearizableReadLoop","detail":"{readStateIndex:1999; appliedIndex:1998; }","duration":"119.305971ms","start":"2026-09-22T02:04:29.958595Z","end":"2026-09-22T02:04:30.077901Z","steps":["trace[1271385122] 'read index received' (duration: 119.2479ms)","trace[1271385122] 'applied index is now lower than readState.Index' (duration: 56.861µs)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:04:30.078083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.157764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-22T02:04:30.078115Z","caller":"traceutil/trace.go:171","msg":"trace[690197048] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1925; }","duration":"212.237694ms","start":"2026-09-22T02:04:29.865866Z","end":"2026-09-22T02:04:30.078104Z","steps":["trace[690197048] 'agreement among raft nodes before linearized reading' (duration: 212.166333ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:04:30.078053Z","caller":"traceutil/trace.go:171","msg":"trace[1932849187] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"236.47265ms","start":"2026-09-22T02:04:29.841549Z","end":"2026-09-22T02:04:30.078021Z","steps":["trace[1932849187] 'process raft request' (duration: 236.206869ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:04:30.090184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.477678ms","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-09-22T02:04:30.090244Z","caller":"traceutil/trace.go:171","msg":"trace[1061423022] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1926; }","duration":"100.585368ms","start":"2026-09-22T02:04:29.989639Z","end":"2026-09-22T02:04:30.090224Z","steps":["trace[1061423022] 'agreement among raft nodes before linearized reading' (duration: 100.407767ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:04:30.09025Z","caller":"traceutil/trace.go:171","msg":"trace[1661045883] transaction","detail":"{read_only:false; response_revision:1926; number_of_response:1; }","duration":"122.581001ms","start":"2026-09-22T02:04:29.96749Z","end":"2026-09-22T02:04:30.090071Z","steps":["trace[1661045883] 'process raft request' (duration: 122.4569ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:04:30.910834Z","caller":"traceutil/trace.go:171","msg":"trace[362972462] transaction","detail":"{read_only:false; response_revision:1933; number_of_response:1; }","duration":"101.566915ms","start":"2026-09-22T02:04:30.809242Z","end":"2026-09-22T02:04:30.910809Z","steps":["trace[362972462] 'process raft request' (duration: 101.421044ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:04:31.145328Z","caller":"traceutil/trace.go:171","msg":"trace[1486519300] transaction","detail":"{read_only:false; response_revision:1935; number_of_response:1; }","duration":"219.953162ms","start":"2026-09-22T02:04:30.925335Z","end":"2026-09-22T02:04:31.145288Z","steps":["trace[1486519300] 'process raft request' (duration: 202.323518ms)","trace[1486519300] 'compare' (duration: 17.10556ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:04:31.415156Z","caller":"traceutil/trace.go:171","msg":"trace[413276252] transaction","detail":"{read_only:false; response_revision:1937; number_of_response:1; }","duration":"111.195583ms","start":"2026-09-22T02:04:31.303903Z","end":"2026-09-22T02:04:31.415098Z","steps":["trace[413276252] 'process raft request' (duration: 77.994429ms)","trace[413276252] 'compare' (duration: 33.040873ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:04:31.415123Z","caller":"traceutil/trace.go:171","msg":"trace[14646360] linearizableReadLoop","detail":"{readStateIndex:2012; appliedIndex:2011; }","duration":"105.98849ms","start":"2026-09-22T02:04:31.309099Z","end":"2026-09-22T02:04:31.415087Z","steps":["trace[14646360] 'read index received' (duration: 72.722296ms)","trace[14646360] 'applied index is now lower than readState.Index' (duration: 33.264964ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:04:31.415943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.809424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-22T02:04:31.416014Z","caller":"traceutil/trace.go:171","msg":"trace[1879676230] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1937; }","duration":"106.954055ms","start":"2026-09-22T02:04:31.309042Z","end":"2026-09-22T02:04:31.415996Z","steps":["trace[1879676230] 'agreement among raft nodes before linearized reading' (duration: 106.176111ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:04:42.265059Z","caller":"traceutil/trace.go:171","msg":"trace[1464910970] transaction","detail":"{read_only:false; response_revision:2024; number_of_response:1; }","duration":"130.693609ms","start":"2026-09-22T02:04:42.134342Z","end":"2026-09-22T02:04:42.265036Z","steps":["trace[1464910970] 'process raft request' (duration: 130.576688ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:04:42.265849Z","caller":"traceutil/trace.go:171","msg":"trace[1384074346] linearizableReadLoop","detail":"{readStateIndex:2103; appliedIndex:2101; }","duration":"111.131201ms","start":"2026-09-22T02:04:42.154681Z","end":"2026-09-22T02:04:42.265812Z","steps":["trace[1384074346] 'read index received' (duration: 110.201405ms)","trace[1384074346] 'applied index is now lower than readState.Index' (duration: 928.916µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:04:42.266228Z","caller":"traceutil/trace.go:171","msg":"trace[101746234] transaction","detail":"{read_only:false; response_revision:2025; number_of_response:1; }","duration":"113.360295ms","start":"2026-09-22T02:04:42.152852Z","end":"2026-09-22T02:04:42.266212Z","steps":["trace[101746234] 'process raft request' (duration: 112.814121ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:04:42.266386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.691775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-09-22T02:04:42.266437Z","caller":"traceutil/trace.go:171","msg":"trace[291232175] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2025; }","duration":"111.759985ms","start":"2026-09-22T02:04:42.154651Z","end":"2026-09-22T02:04:42.266411Z","steps":["trace[291232175] 'agreement among raft nodes before linearized reading' (duration: 111.659164ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:04:59.995242Z","caller":"traceutil/trace.go:171","msg":"trace[1019194511] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"329.957525ms","start":"2026-09-22T02:04:59.665259Z","end":"2026-09-22T02:04:59.995217Z","steps":["trace[1019194511] 'process raft request' (duration: 329.781184ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:04:59.995385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:04:59.665236Z","time spent":"330.077276ms","remote":"127.0.0.1:49606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T02:05:00.360368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.479984ms","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-22T02:05:00.360448Z","caller":"traceutil/trace.go:171","msg":"trace[1420055465] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2140; }","duration":"250.680985ms","start":"2026-09-22T02:05:00.109748Z","end":"2026-09-22T02:05:00.360429Z","steps":["trace[1420055465] 'range keys from in-memory index tree' (duration: 250.292913ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:05:00.627454Z","caller":"traceutil/trace.go:171","msg":"trace[2000351822] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"222.380618ms","start":"2026-09-22T02:05:00.405044Z","end":"2026-09-22T02:05:00.627425Z","steps":["trace[2000351822] 'process raft request' (duration: 222.261927ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:05:00.627506Z","caller":"traceutil/trace.go:171","msg":"trace[1425390402] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"263.349356ms","start":"2026-09-22T02:05:00.364129Z","end":"2026-09-22T02:05:00.627478Z","steps":["trace[1425390402] 'process raft request' (duration: 262.961784ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:05:00.627763Z","caller":"traceutil/trace.go:171","msg":"trace[1510834456] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"210.891714ms","start":"2026-09-22T02:05:00.416858Z","end":"2026-09-22T02:05:00.62775Z","steps":["trace[1510834456] 'process raft request' (duration: 210.796883ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:05:00.627837Z","caller":"traceutil/trace.go:171","msg":"trace[2026233240] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"210.923344ms","start":"2026-09-22T02:05:00.416895Z","end":"2026-09-22T02:05:00.627819Z","steps":["trace[2026233240] 'process raft request' (duration: 210.824383ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:05:00.627843Z","caller":"traceutil/trace.go:171","msg":"trace[507359221] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"211.058075ms","start":"2026-09-22T02:05:00.416751Z","end":"2026-09-22T02:05:00.62781Z","steps":["trace[507359221] 'process raft request' (duration: 210.625512ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:05:00.649733Z","caller":"traceutil/trace.go:171","msg":"trace[1318462738] linearizableReadLoop","detail":"{readStateIndex:2228; appliedIndex:2222; }","duration":"188.754911ms","start":"2026-09-22T02:05:00.460957Z","end":"2026-09-22T02:05:00.649712Z","steps":["trace[1318462738] 'read index received' (duration: 166.215885ms)","trace[1318462738] 'applied index is now lower than readState.Index' (duration: 22.538066ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:05:00.649817Z","caller":"traceutil/trace.go:171","msg":"trace[2034712587] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"229.595357ms","start":"2026-09-22T02:05:00.420198Z","end":"2026-09-22T02:05:00.649794Z","steps":["trace[2034712587] 'process raft request' (duration: 229.428746ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:05:00.650016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.038683ms","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-09-22T02:05:00.650074Z","caller":"traceutil/trace.go:171","msg":"trace[349300531] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2146; }","duration":"189.135533ms","start":"2026-09-22T02:05:00.460924Z","end":"2026-09-22T02:05:00.65006Z","steps":["trace[349300531] 'agreement among raft nodes before linearized reading' (duration: 188.933112ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:05:00.809408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.930196ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T02:05:00.809495Z","caller":"traceutil/trace.go:171","msg":"trace[1605026801] linearizableReadLoop","detail":"{readStateIndex:2229; appliedIndex:2228; }","duration":"155.801748ms","start":"2026-09-22T02:05:00.65368Z","end":"2026-09-22T02:05:00.809482Z","steps":["trace[1605026801] 'read index received' (duration: 46.614371ms)","trace[1605026801] 'applied index is now lower than readState.Index' (duration: 109.186287ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:05:00.809529Z","caller":"traceutil/trace.go:171","msg":"trace[2016570015] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"156.34474ms","start":"2026-09-22T02:05:00.653163Z","end":"2026-09-22T02:05:00.809507Z","steps":["trace[2016570015] 'process raft request' (duration: 47.244143ms)","trace[2016570015] 'compare' (duration: 108.829656ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:05:00.8098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.049649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-09-22T02:05:00.809863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.947071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-22T02:05:00.809902Z","caller":"traceutil/trace.go:171","msg":"trace[1566881182] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:2147; }","duration":"156.22135ms","start":"2026-09-22T02:05:00.653656Z","end":"2026-09-22T02:05:00.809878Z","steps":["trace[1566881182] 'agreement among raft nodes before linearized reading' (duration: 155.895488ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:05:00.809902Z","caller":"traceutil/trace.go:171","msg":"trace[445074549] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2147; }","duration":"143.986281ms","start":"2026-09-22T02:05:00.665903Z","end":"2026-09-22T02:05:00.80989Z","steps":["trace[445074549] 'agreement among raft nodes before linearized reading' (duration: 143.81103ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:05:01.813001Z","caller":"traceutil/trace.go:171","msg":"trace[1608507406] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"384.060359ms","start":"2026-09-22T02:05:01.428918Z","end":"2026-09-22T02:05:01.812978Z","steps":["trace[1608507406] 'process raft request' (duration: 383.924429ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:05:01.81313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:05:01.428899Z","time spent":"384.1667ms","remote":"127.0.0.1:49606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T02:05:01.813339Z","caller":"traceutil/trace.go:171","msg":"trace[282772841] linearizableReadLoop","detail":"{readStateIndex:2231; appliedIndex:2231; }","duration":"375.869753ms","start":"2026-09-22T02:05:01.437457Z","end":"2026-09-22T02:05:01.813327Z","steps":["trace[282772841] 'read index received' (duration: 375.865233ms)","trace[282772841] 'applied index is now lower than readState.Index' (duration: 3.61µs)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:05:01.81344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.904117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-22T02:05:01.813473Z","caller":"traceutil/trace.go:171","msg":"trace[575434859] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:2149; }","duration":"300.964757ms","start":"2026-09-22T02:05:01.5125Z","end":"2026-09-22T02:05:01.813464Z","steps":["trace[575434859] 'agreement among raft nodes before linearized reading' (duration: 300.890207ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:05:01.813499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:05:01.512487Z","time spent":"301.004547ms","remote":"127.0.0.1:49844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":36,"response size":30,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"warn","ts":"2026-09-22T02:05:01.813715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.225805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-22T02:05:01.813878Z","caller":"traceutil/trace.go:171","msg":"trace[420448964] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:2149; }","duration":"376.430138ms","start":"2026-09-22T02:05:01.437426Z","end":"2026-09-22T02:05:01.813856Z","steps":["trace[420448964] 'agreement among raft nodes before linearized reading' (duration: 376.210026ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:05:01.814035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:05:01.437414Z","time spent":"376.605528ms","remote":"127.0.0.1:32830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":2,"response size":30,"request content":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true "} {"level":"warn","ts":"2026-09-22T02:05:03.071185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.614181ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T02:05:03.071345Z","caller":"traceutil/trace.go:171","msg":"trace[806716684] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"645.257941ms","start":"2026-09-22T02:05:02.426057Z","end":"2026-09-22T02:05:03.071315Z","steps":["trace[806716684] 'process raft request' (duration: 144.423908ms)","trace[806716684] 'compare' (duration: 500.493831ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:05:03.07141Z","caller":"traceutil/trace.go:171","msg":"trace[444375821] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"438.106437ms","start":"2026-09-22T02:05:02.633282Z","end":"2026-09-22T02:05:03.071389Z","steps":["trace[444375821] 'process raft request' (duration: 438.028357ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:05:03.071455Z","caller":"traceutil/trace.go:171","msg":"trace[140536458] linearizableReadLoop","detail":"{readStateIndex:2235; appliedIndex:2234; }","duration":"582.891946ms","start":"2026-09-22T02:05:02.488537Z","end":"2026-09-22T02:05:03.071428Z","steps":["trace[140536458] 'read index received' (duration: 81.936953ms)","trace[140536458] 'applied index is now lower than readState.Index' (duration: 500.953643ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:05:03.071485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:05:02.426036Z","time spent":"645.372211ms","remote":"127.0.0.1:49446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T02:05:03.071499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:05:02.633264Z","time spent":"438.195268ms","remote":"127.0.0.1:49606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T02:05:03.071649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.103168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T02:05:03.071687Z","caller":"traceutil/trace.go:171","msg":"trace[351104227] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2153; }","duration":"583.155568ms","start":"2026-09-22T02:05:02.488523Z","end":"2026-09-22T02:05:03.071678Z","steps":["trace[351104227] 'agreement among raft nodes before linearized reading' (duration: 583.017767ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:05:03.071716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:05:02.488478Z","time spent":"583.231068ms","remote":"127.0.0.1:49772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-09-22T02:05:03.089932Z","caller":"traceutil/trace.go:171","msg":"trace[981235207] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"456.626209ms","start":"2026-09-22T02:05:02.633282Z","end":"2026-09-22T02:05:03.089909Z","steps":["trace[981235207] 'process raft request' (duration: 456.417468ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:05:03.090086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:05:02.633268Z","time spent":"456.735479ms","remote":"127.0.0.1:49606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T02:05:03.090421Z","caller":"traceutil/trace.go:171","msg":"trace[1113620473] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"456.891221ms","start":"2026-09-22T02:05:02.63351Z","end":"2026-09-22T02:05:03.090401Z","steps":["trace[1113620473] 'process raft request' (duration: 456.359908ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:05:03.090561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:05:02.633498Z","time spent":"456.993431ms","remote":"127.0.0.1:49606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T02:05:03.090828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.431324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-09-22T02:05:03.090866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.645753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T02:05:03.090885Z","caller":"traceutil/trace.go:171","msg":"trace[156030195] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2156; }","duration":"276.526515ms","start":"2026-09-22T02:05:02.814345Z","end":"2026-09-22T02:05:03.090871Z","steps":["trace[156030195] 'agreement among raft nodes before linearized reading' (duration: 276.346193ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:05:03.090917Z","caller":"traceutil/trace.go:171","msg":"trace[136693589] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2156; }","duration":"482.738284ms","start":"2026-09-22T02:05:02.608166Z","end":"2026-09-22T02:05:03.090904Z","steps":["trace[136693589] 'agreement among raft nodes before linearized reading' (duration: 482.654543ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:05:03.090932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.70701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-09-22T02:05:03.090972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.322449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-09-22T02:05:03.090986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:05:02.608145Z","time spent":"482.831184ms","remote":"127.0.0.1:49370","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-09-22T02:05:03.090999Z","caller":"traceutil/trace.go:171","msg":"trace[2054559482] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2156; }","duration":"458.827891ms","start":"2026-09-22T02:05:02.632154Z","end":"2026-09-22T02:05:03.090982Z","steps":["trace[2054559482] 'agreement among raft nodes before linearized reading' (duration: 458.523309ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:05:03.09101Z","caller":"traceutil/trace.go:171","msg":"trace[589355487] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2156; }","duration":"268.378059ms","start":"2026-09-22T02:05:02.82262Z","end":"2026-09-22T02:05:03.090998Z","steps":["trace[589355487] 'agreement among raft nodes before linearized reading' (duration: 268.246099ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:05:03.091053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:05:02.63213Z","time spent":"458.900451ms","remote":"127.0.0.1:49606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-22T02:05:03.091399Z","caller":"traceutil/trace.go:171","msg":"trace[1005328511] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"457.816006ms","start":"2026-09-22T02:05:02.633568Z","end":"2026-09-22T02:05:03.091384Z","steps":["trace[1005328511] 'process raft request' (duration: 456.744489ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:05:03.091508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:05:02.633557Z","time spent":"457.881217ms","remote":"127.0.0.1:49606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T02:05:03.633314Z","caller":"traceutil/trace.go:171","msg":"trace[1439029603] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"263.258628ms","start":"2026-09-22T02:05:03.370029Z","end":"2026-09-22T02:05:03.633288Z","steps":["trace[1439029603] 'process raft request' (duration: 263.119567ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:05:04.02149Z","caller":"traceutil/trace.go:171","msg":"trace[559066770] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"125.203358ms","start":"2026-09-22T02:05:03.896256Z","end":"2026-09-22T02:05:04.021459Z","steps":["trace[559066770] 'process raft request' (duration: 124.703736ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:05:04.184561Z","caller":"traceutil/trace.go:171","msg":"trace[1557760877] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"106.365143ms","start":"2026-09-22T02:05:04.078167Z","end":"2026-09-22T02:05:04.184532Z","steps":["trace[1557760877] 'process raft request' (duration: 98.057978ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:06:41.617996Z","caller":"traceutil/trace.go:171","msg":"trace[1029241555] transaction","detail":"{read_only:false; response_revision:2717; number_of_response:1; }","duration":"127.784421ms","start":"2026-09-22T02:06:41.490186Z","end":"2026-09-22T02:06:41.617971Z","steps":["trace[1029241555] 'process raft request' (duration: 120.613035ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:06:41.618Z","caller":"traceutil/trace.go:171","msg":"trace[846433912] transaction","detail":"{read_only:false; response_revision:2718; number_of_response:1; }","duration":"101.125519ms","start":"2026-09-22T02:06:41.516859Z","end":"2026-09-22T02:06:41.617985Z","steps":["trace[846433912] 'process raft request' (duration: 101.055277ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:07:23.037335Z","caller":"traceutil/trace.go:171","msg":"trace[1492666563] transaction","detail":"{read_only:false; response_revision:3002; number_of_response:1; }","duration":"163.57081ms","start":"2026-09-22T02:07:22.873741Z","end":"2026-09-22T02:07:23.037312Z","steps":["trace[1492666563] 'process raft request' (duration: 163.436536ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:07:28.520299Z","caller":"traceutil/trace.go:171","msg":"trace[1837238792] transaction","detail":"{read_only:false; response_revision:3031; number_of_response:1; }","duration":"167.762874ms","start":"2026-09-22T02:07:28.35251Z","end":"2026-09-22T02:07:28.520273Z","steps":["trace[1837238792] 'process raft request' (duration: 167.58487ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:10:57.59773Z","caller":"traceutil/trace.go:171","msg":"trace[1845969671] transaction","detail":"{read_only:false; response_revision:4247; number_of_response:1; }","duration":"113.703254ms","start":"2026-09-22T02:10:57.483995Z","end":"2026-09-22T02:10:57.597698Z","steps":["trace[1845969671] 'process raft request' (duration: 96.482657ms)","trace[1845969671] 'compare' (duration: 16.752002ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:10:57.59826Z","caller":"traceutil/trace.go:171","msg":"trace[1748729760] linearizableReadLoop","detail":"{readStateIndex:4413; appliedIndex:4412; }","duration":"101.239449ms","start":"2026-09-22T02:10:57.497001Z","end":"2026-09-22T02:10:57.59824Z","steps":["trace[1748729760] 'read index received' (duration: 83.416706ms)","trace[1748729760] 'applied index is now lower than readState.Index' (duration: 17.820493ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:10:57.598949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.424651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/alertmanagers.monitoring.coreos.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T02:10:57.599147Z","caller":"traceutil/trace.go:171","msg":"trace[388352389] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/alertmanagers.monitoring.coreos.com; range_end:; response_count:0; response_revision:4248; }","duration":"102.131149ms","start":"2026-09-22T02:10:57.496996Z","end":"2026-09-22T02:10:57.599127Z","steps":["trace[388352389] 'agreement among raft nodes before linearized reading' (duration: 101.33445ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:35.475968Z","caller":"traceutil/trace.go:171","msg":"trace[315149017] transaction","detail":"{read_only:false; response_revision:4497; number_of_response:1; }","duration":"164.331257ms","start":"2026-09-22T02:11:35.311607Z","end":"2026-09-22T02:11:35.475939Z","steps":["trace[315149017] 'process raft request' (duration: 163.461778ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:47.023761Z","caller":"traceutil/trace.go:171","msg":"trace[1219106314] linearizableReadLoop","detail":"{readStateIndex:5122; appliedIndex:5120; }","duration":"177.495322ms","start":"2026-09-22T02:11:46.846246Z","end":"2026-09-22T02:11:47.023741Z","steps":["trace[1219106314] 'read index received' (duration: 164.806744ms)","trace[1219106314] 'applied index is now lower than readState.Index' (duration: 12.687478ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:11:47.023858Z","caller":"traceutil/trace.go:171","msg":"trace[1180544392] transaction","detail":"{read_only:false; response_revision:4931; number_of_response:1; }","duration":"269.447229ms","start":"2026-09-22T02:11:46.754365Z","end":"2026-09-22T02:11:47.023812Z","steps":["trace[1180544392] 'process raft request' (duration: 256.676551ms)","trace[1180544392] 'compare' (duration: 12.322504ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:11:47.023909Z","caller":"traceutil/trace.go:171","msg":"trace[931879696] transaction","detail":"{read_only:false; response_revision:4932; number_of_response:1; }","duration":"263.194367ms","start":"2026-09-22T02:11:46.760656Z","end":"2026-09-22T02:11:47.02385Z","steps":["trace[931879696] 'process raft request' (duration: 263.027175ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:11:47.024148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.888596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-admission-patch-jqw92\" ","response":"range_response_count:1 size:4655"} {"level":"info","ts":"2026-09-22T02:11:47.024252Z","caller":"traceutil/trace.go:171","msg":"trace[1519625812] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-admission-patch-jqw92; range_end:; response_count:1; response_revision:4932; }","duration":"178.036938ms","start":"2026-09-22T02:11:46.846195Z","end":"2026-09-22T02:11:47.024232Z","steps":["trace[1519625812] 'agreement among raft nodes before linearized reading' (duration: 177.764505ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:47.026677Z","caller":"traceutil/trace.go:171","msg":"trace[830718366] transaction","detail":"{read_only:false; response_revision:4933; number_of_response:1; }","duration":"127.133239ms","start":"2026-09-22T02:11:46.899522Z","end":"2026-09-22T02:11:47.026655Z","steps":["trace[830718366] 'process raft request' (duration: 126.530902ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:47.0267Z","caller":"traceutil/trace.go:171","msg":"trace[279990200] transaction","detail":"{read_only:false; response_revision:4934; number_of_response:1; }","duration":"126.944497ms","start":"2026-09-22T02:11:46.899729Z","end":"2026-09-22T02:11:47.026674Z","steps":["trace[279990200] 'process raft request' (duration: 126.465812ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:47.197343Z","caller":"traceutil/trace.go:171","msg":"trace[188608927] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"126.781834ms","start":"2026-09-22T02:11:47.070525Z","end":"2026-09-22T02:11:47.197307Z","steps":["trace[188608927] 'process raft request' (duration: 126.559472ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:47.197379Z","caller":"traceutil/trace.go:171","msg":"trace[1045567538] transaction","detail":"{read_only:false; response_revision:4937; number_of_response:1; }","duration":"136.691702ms","start":"2026-09-22T02:11:47.060655Z","end":"2026-09-22T02:11:47.197347Z","steps":["trace[1045567538] 'process raft request' (duration: 103.050487ms)","trace[1045567538] 'compare' (duration: 33.0893ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:11:47.197867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.918303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:5 size:35437"} {"level":"info","ts":"2026-09-22T02:11:47.197914Z","caller":"traceutil/trace.go:171","msg":"trace[2006406478] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:5; response_revision:4938; }","duration":"157.003494ms","start":"2026-09-22T02:11:47.040899Z","end":"2026-09-22T02:11:47.197903Z","steps":["trace[2006406478] 'agreement among raft nodes before linearized reading' (duration: 156.780752ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:48.211932Z","caller":"traceutil/trace.go:171","msg":"trace[1668868994] transaction","detail":"{read_only:false; response_revision:4992; number_of_response:1; }","duration":"107.798953ms","start":"2026-09-22T02:11:48.104113Z","end":"2026-09-22T02:11:48.211912Z","steps":["trace[1668868994] 'process raft request' (duration: 102.063816ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:52.355885Z","caller":"traceutil/trace.go:171","msg":"trace[1110416338] transaction","detail":"{read_only:false; response_revision:5088; number_of_response:1; }","duration":"108.636685ms","start":"2026-09-22T02:11:52.247165Z","end":"2026-09-22T02:11:52.355802Z","steps":["trace[1110416338] 'process raft request' (duration: 108.00462ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:11:52.35616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.465134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-09-22T02:11:52.356246Z","caller":"traceutil/trace.go:171","msg":"trace[1462183611] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5088; }","duration":"100.583395ms","start":"2026-09-22T02:11:52.255643Z","end":"2026-09-22T02:11:52.356227Z","steps":["trace[1462183611] 'agreement among raft nodes before linearized reading' (duration: 99.683726ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:53.09386Z","caller":"traceutil/trace.go:171","msg":"trace[216261352] transaction","detail":"{read_only:false; response_revision:5107; number_of_response:1; }","duration":"173.415044ms","start":"2026-09-22T02:11:52.92042Z","end":"2026-09-22T02:11:53.093835Z","steps":["trace[216261352] 'process raft request' (duration: 172.717077ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:57.026162Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2864} {"level":"info","ts":"2026-09-22T02:11:57.209324Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2864,"took":"181.994807ms","hash":3095283420,"current-db-size-bytes":51535872,"current-db-size":"52 MB","current-db-size-in-use-bytes":26664960,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-22T02:11:57.209364Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3095283420,"revision":2864,"compact-revision":-1} {"level":"warn","ts":"2026-09-22T02:11:59.71494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.786226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T02:11:59.715069Z","caller":"traceutil/trace.go:171","msg":"trace[1863365724] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5215; }","duration":"107.938269ms","start":"2026-09-22T02:11:59.607084Z","end":"2026-09-22T02:11:59.715022Z","steps":["trace[1863365724] 'range keys from in-memory index tree' (duration: 107.712706ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:11:59.715077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.523455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"warn","ts":"2026-09-22T02:11:59.715878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.885616ms","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-22T02:11:59.715873Z","caller":"traceutil/trace.go:171","msg":"trace[646316669] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5215; }","duration":"400.334563ms","start":"2026-09-22T02:11:59.315516Z","end":"2026-09-22T02:11:59.715851Z","steps":["trace[646316669] 'range keys from in-memory index tree' (duration: 399.329754ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:59.715932Z","caller":"traceutil/trace.go:171","msg":"trace[1440563719] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5215; }","duration":"361.000807ms","start":"2026-09-22T02:11:59.354912Z","end":"2026-09-22T02:11:59.715912Z","steps":["trace[1440563719] 'range keys from in-memory index tree' (duration: 360.706364ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:11:59.715939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:11:59.315502Z","time spent":"400.422794ms","remote":"127.0.0.1:49606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":553,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-09-22T02:11:59.715971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:11:59.354896Z","time spent":"361.066928ms","remote":"127.0.0.1:49606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-22T02:11:59.715767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.832569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d88dd44d-8ac4-4ceb-ad53-8ea0c69a7796\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-09-22T02:11:59.716134Z","caller":"traceutil/trace.go:171","msg":"trace[1447272449] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d88dd44d-8ac4-4ceb-ad53-8ea0c69a7796; range_end:; response_count:1; response_revision:5215; }","duration":"343.285373ms","start":"2026-09-22T02:11:59.372806Z","end":"2026-09-22T02:11:59.716092Z","steps":["trace[1447272449] 'range keys from in-memory index tree' (duration: 342.645237ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:11:59.716202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:11:59.372786Z","time spent":"343.401614ms","remote":"127.0.0.1:49564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d88dd44d-8ac4-4ceb-ad53-8ea0c69a7796\" "} {"level":"warn","ts":"2026-09-22T02:11:59.715777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.130864ms","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-09-22T02:11:59.71641Z","caller":"traceutil/trace.go:171","msg":"trace[128253357] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5215; }","duration":"332.806551ms","start":"2026-09-22T02:11:59.383593Z","end":"2026-09-22T02:11:59.7164Z","steps":["trace[128253357] 'range keys from in-memory index tree' (duration: 331.966043ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:11:59.716439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:11:59.383583Z","time spent":"332.847101ms","remote":"127.0.0.1:49606","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-09-22T02:11:59.822417Z","caller":"traceutil/trace.go:171","msg":"trace[1952608008] transaction","detail":"{read_only:false; response_revision:5216; number_of_response:1; }","duration":"101.422364ms","start":"2026-09-22T02:11:59.720972Z","end":"2026-09-22T02:11:59.822394Z","steps":["trace[1952608008] 'process raft request' (duration: 100.912799ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:59.857803Z","caller":"traceutil/trace.go:171","msg":"trace[752850415] transaction","detail":"{read_only:false; response_revision:5218; number_of_response:1; }","duration":"136.195365ms","start":"2026-09-22T02:11:59.721568Z","end":"2026-09-22T02:11:59.857763Z","steps":["trace[752850415] 'process raft request' (duration: 136.145334ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:11:59.857842Z","caller":"traceutil/trace.go:171","msg":"trace[2107283654] transaction","detail":"{read_only:false; response_revision:5217; number_of_response:1; }","duration":"136.335306ms","start":"2026-09-22T02:11:59.721468Z","end":"2026-09-22T02:11:59.857804Z","steps":["trace[2107283654] 'process raft request' (duration: 136.068434ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:12:00.33838Z","caller":"traceutil/trace.go:171","msg":"trace[1953277910] linearizableReadLoop","detail":"{readStateIndex:5418; appliedIndex:5417; }","duration":"270.223964ms","start":"2026-09-22T02:12:00.068134Z","end":"2026-09-22T02:12:00.338358Z","steps":["trace[1953277910] 'read index received' (duration: 222.75446ms)","trace[1953277910] 'applied index is now lower than readState.Index' (duration: 47.467944ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:12:00.338437Z","caller":"traceutil/trace.go:171","msg":"trace[895152005] transaction","detail":"{read_only:false; response_revision:5221; number_of_response:1; }","duration":"356.834163ms","start":"2026-09-22T02:11:59.981565Z","end":"2026-09-22T02:12:00.338399Z","steps":["trace[895152005] 'process raft request' (duration: 309.419789ms)","trace[895152005] 'compare' (duration: 46.997799ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:12:00.338595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.192358ms","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-09-22T02:12:00.338622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:11:59.981545Z","time spent":"356.974504ms","remote":"127.0.0.1:49564","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3747,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T02:12:00.338659Z","caller":"traceutil/trace.go:171","msg":"trace[741335341] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5221; }","duration":"113.308749ms","start":"2026-09-22T02:12:00.22534Z","end":"2026-09-22T02:12:00.338649Z","steps":["trace[741335341] 'agreement among raft nodes before linearized reading' (duration: 113.141537ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:12:00.33865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.490977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-22T02:12:00.338782Z","caller":"traceutil/trace.go:171","msg":"trace[236021900] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5221; }","duration":"270.648979ms","start":"2026-09-22T02:12:00.068086Z","end":"2026-09-22T02:12:00.338735Z","steps":["trace[236021900] 'agreement among raft nodes before linearized reading' (duration: 270.339866ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:12:00.552254Z","caller":"traceutil/trace.go:171","msg":"trace[1369215225] transaction","detail":"{read_only:false; response_revision:5223; number_of_response:1; }","duration":"147.962438ms","start":"2026-09-22T02:12:00.40426Z","end":"2026-09-22T02:12:00.552223Z","steps":["trace[1369215225] 'process raft request' (duration: 147.509094ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:12:00.552751Z","caller":"traceutil/trace.go:171","msg":"trace[1324879916] transaction","detail":"{read_only:false; response_revision:5224; number_of_response:1; }","duration":"132.580698ms","start":"2026-09-22T02:12:00.419617Z","end":"2026-09-22T02:12:00.552198Z","steps":["trace[1324879916] 'process raft request' (duration: 132.467147ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:12:14.32638Z","caller":"traceutil/trace.go:171","msg":"trace[325177867] linearizableReadLoop","detail":"{readStateIndex:5612; appliedIndex:5611; }","duration":"186.507472ms","start":"2026-09-22T02:12:14.139852Z","end":"2026-09-22T02:12:14.326359Z","steps":["trace[325177867] 'read index received' (duration: 156.962428ms)","trace[325177867] 'applied index is now lower than readState.Index' (duration: 29.544034ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:12:14.326625Z","caller":"traceutil/trace.go:171","msg":"trace[27240544] transaction","detail":"{read_only:false; response_revision:5409; number_of_response:1; }","duration":"308.232862ms","start":"2026-09-22T02:12:14.018378Z","end":"2026-09-22T02:12:14.326611Z","steps":["trace[27240544] 'process raft request' (duration: 278.607588ms)","trace[27240544] 'compare' (duration: 29.274681ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:12:14.326719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:12:14.018364Z","time spent":"308.285223ms","remote":"127.0.0.1:49606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T02:12:14.326957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.114469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13283"} {"level":"info","ts":"2026-09-22T02:12:14.326989Z","caller":"traceutil/trace.go:171","msg":"trace[1205312897] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5409; }","duration":"187.180049ms","start":"2026-09-22T02:12:14.139799Z","end":"2026-09-22T02:12:14.326979Z","steps":["trace[1205312897] 'agreement among raft nodes before linearized reading' (duration: 187.049098ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:12:14.327186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.544774ms","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-22T02:12:14.327213Z","caller":"traceutil/trace.go:171","msg":"trace[502247511] 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:5409; }","duration":"107.636415ms","start":"2026-09-22T02:12:14.219567Z","end":"2026-09-22T02:12:14.327204Z","steps":["trace[502247511] 'agreement among raft nodes before linearized reading' (duration: 107.557344ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:12:14.446242Z","caller":"traceutil/trace.go:171","msg":"trace[733454100] transaction","detail":"{read_only:false; response_revision:5410; number_of_response:1; }","duration":"102.557336ms","start":"2026-09-22T02:12:14.343664Z","end":"2026-09-22T02:12:14.446222Z","steps":["trace[733454100] 'process raft request' (duration: 99.823179ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:12:56.654809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.735599ms","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-09-22T02:12:56.654895Z","caller":"traceutil/trace.go:171","msg":"trace[395054452] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5752; }","duration":"132.87492ms","start":"2026-09-22T02:12:56.522Z","end":"2026-09-22T02:12:56.654875Z","steps":["trace[395054452] 'range keys from in-memory index tree' (duration: 132.565387ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:16:57.033734Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5133} {"level":"info","ts":"2026-09-22T02:16:57.117882Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5133,"took":"82.347775ms","hash":940479953,"current-db-size-bytes":51535872,"current-db-size":"52 MB","current-db-size-in-use-bytes":19755008,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-09-22T02:16:57.117927Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":940479953,"revision":5133,"compact-revision":2864}