{"level":"warn","ts":"2026-09-15T22:19:19.403621Z","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-15T22:19:19.403755Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.119: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.119:2380","--initial-cluster=instance=https://162.253.55.119:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.119:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.119: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-15T22:19:19.403879Z","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-15T22:19:19.4039Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.119:2380"]} {"level":"info","ts":"2026-09-15T22:19:19.403921Z","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-15T22:19:19.404578Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.119:2379"]} {"level":"info","ts":"2026-09-15T22:19:19.404667Z","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.119:2380"],"listen-peer-urls":["https://162.253.55.119:2380"],"advertise-client-urls":["https://162.253.55.119:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.119:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.119: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-15T22:19:19.410569Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.685168ms"} {"level":"info","ts":"2026-09-15T22:19:19.422896Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2f0e00eb3c3ee1b","cluster-id":"8e467f099f65c603"} {"level":"info","ts":"2026-09-15T22:19:19.422993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b switched to configuration voters=()"} {"level":"info","ts":"2026-09-15T22:19:19.423022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became follower at term 0"} {"level":"info","ts":"2026-09-15T22:19:19.423033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2f0e00eb3c3ee1b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-15T22:19:19.423043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became follower at term 1"} {"level":"info","ts":"2026-09-15T22:19:19.423086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b switched to configuration voters=(211915536236539419)"} {"level":"warn","ts":"2026-09-15T22:19:19.434682Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-15T22:19:19.436403Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-15T22:19:19.43953Z","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-15T22:19:19.445876Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2f0e00eb3c3ee1b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-15T22:19:19.446381Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2f0e00eb3c3ee1b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-15T22:19:19.446509Z","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-15T22:19:19.446542Z","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-15T22:19:19.446559Z","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-15T22:19:19.45243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b switched to configuration voters=(211915536236539419)"} {"level":"info","ts":"2026-09-15T22:19:19.452614Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8e467f099f65c603","local-member-id":"2f0e00eb3c3ee1b","added-peer-id":"2f0e00eb3c3ee1b","added-peer-peer-urls":["https://162.253.55.119:2380"]} {"level":"info","ts":"2026-09-15T22:19:19.453703Z","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-15T22:19:19.453881Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2f0e00eb3c3ee1b","initial-advertise-peer-urls":["https://162.253.55.119:2380"],"listen-peer-urls":["https://162.253.55.119:2380"],"advertise-client-urls":["https://162.253.55.119:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.119:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-15T22:19:19.4539Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-15T22:19:19.454003Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.119:2380"} {"level":"info","ts":"2026-09-15T22:19:19.454012Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.119:2380"} {"level":"info","ts":"2026-09-15T22:19:19.927103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b is starting a new election at term 1"} {"level":"info","ts":"2026-09-15T22:19:19.927173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became pre-candidate at term 1"} {"level":"info","ts":"2026-09-15T22:19:19.92722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b received MsgPreVoteResp from 2f0e00eb3c3ee1b at term 1"} {"level":"info","ts":"2026-09-15T22:19:19.927236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became candidate at term 2"} {"level":"info","ts":"2026-09-15T22:19:19.927244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b received MsgVoteResp from 2f0e00eb3c3ee1b at term 2"} {"level":"info","ts":"2026-09-15T22:19:19.927254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became leader at term 2"} {"level":"info","ts":"2026-09-15T22:19:19.927404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2f0e00eb3c3ee1b elected leader 2f0e00eb3c3ee1b at term 2"} {"level":"info","ts":"2026-09-15T22:19:19.934543Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T22:19:19.936027Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2f0e00eb3c3ee1b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.119:2379]}","request-path":"/0/members/2f0e00eb3c3ee1b/attributes","cluster-id":"8e467f099f65c603","publish-timeout":"7s"} {"level":"info","ts":"2026-09-15T22:19:19.936457Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-15T22:19:19.936862Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8e467f099f65c603","local-member-id":"2f0e00eb3c3ee1b","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T22:19:19.937031Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T22:19:19.937066Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T22:19:19.937134Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-15T22:19:19.9389Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.119:2379"} {"level":"info","ts":"2026-09-15T22:19:19.939121Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-15T22:19:19.939156Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-15T22:19:19.940174Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-15T22:19:23.719341Z","caller":"traceutil/trace.go:171","msg":"trace[1472288883] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"116.651255ms","start":"2026-09-15T22:19:23.602661Z","end":"2026-09-15T22:19:23.719312Z","steps":["trace[1472288883] 'process raft request' (duration: 116.485024ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:19:24.140181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.098697ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-15T22:19:24.140353Z","caller":"traceutil/trace.go:171","msg":"trace[207436807] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"411.678635ms","start":"2026-09-15T22:19:23.728653Z","end":"2026-09-15T22:19:24.140332Z","steps":["trace[207436807] 'process raft request' (duration: 194.707053ms)","trace[207436807] 'compare' (duration: 215.890996ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T22:19:24.140632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:19:23.728629Z","time spent":"411.970117ms","remote":"127.0.0.1:43730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":525,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-15T22:19:24.18575Z","caller":"traceutil/trace.go:171","msg":"trace[22396909] linearizableReadLoop","detail":"{readStateIndex:253; appliedIndex:251; }","duration":"429.617933ms","start":"2026-09-15T22:19:23.75601Z","end":"2026-09-15T22:19:24.185628Z","steps":["trace[22396909] 'read index received' (duration: 167.365142ms)","trace[22396909] 'applied index is now lower than readState.Index' (duration: 262.251531ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:19:24.185827Z","caller":"traceutil/trace.go:171","msg":"trace[424097531] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"442.503904ms","start":"2026-09-15T22:19:23.743256Z","end":"2026-09-15T22:19:24.185759Z","steps":["trace[424097531] 'process raft request' (duration: 442.170673ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:19:24.186058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.018245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T22:19:24.186141Z","caller":"traceutil/trace.go:171","msg":"trace[579932998] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:247; }","duration":"430.169605ms","start":"2026-09-15T22:19:23.755955Z","end":"2026-09-15T22:19:24.186125Z","steps":["trace[579932998] 'agreement among raft nodes before linearized reading' (duration: 429.969044ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:19:24.186297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:19:23.755933Z","time spent":"430.243695ms","remote":"127.0.0.1:43834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-15T22:19:24.186345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.768692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T22:19:24.186571Z","caller":"traceutil/trace.go:171","msg":"trace[1585897715] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:247; }","duration":"369.966613ms","start":"2026-09-15T22:19:23.816497Z","end":"2026-09-15T22:19:24.186463Z","steps":["trace[1585897715] 'agreement among raft nodes before linearized reading' (duration: 369.600231ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:19:24.186715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:19:23.816474Z","time spent":"370.226984ms","remote":"127.0.0.1:43834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-15T22:19:24.186674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:19:23.743217Z","time spent":"443.064827ms","remote":"127.0.0.1:43794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-15T22:20:02.749798Z","caller":"traceutil/trace.go:171","msg":"trace[777621730] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"259.275634ms","start":"2026-09-15T22:20:02.490486Z","end":"2026-09-15T22:20:02.749762Z","steps":["trace[777621730] 'process raft request' (duration: 250.812513ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:20:02.749819Z","caller":"traceutil/trace.go:171","msg":"trace[1397141489] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"253.370936ms","start":"2026-09-15T22:20:02.496413Z","end":"2026-09-15T22:20:02.749784Z","steps":["trace[1397141489] 'process raft request' (duration: 253.263266ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:20:02.751044Z","caller":"traceutil/trace.go:171","msg":"trace[796006083] transaction","detail":"{read_only:false; number_of_response:0; response_revision:560; }","duration":"239.43501ms","start":"2026-09-15T22:20:02.511592Z","end":"2026-09-15T22:20:02.751027Z","steps":["trace[796006083] 'process raft request' (duration: 239.205689ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:20:02.751322Z","caller":"traceutil/trace.go:171","msg":"trace[941484918] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"233.16542ms","start":"2026-09-15T22:20:02.518135Z","end":"2026-09-15T22:20:02.7513Z","steps":["trace[941484918] 'process raft request' (duration: 232.798118ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:20:02.751483Z","caller":"traceutil/trace.go:171","msg":"trace[115721566] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:580; }","duration":"200.064841ms","start":"2026-09-15T22:20:02.551387Z","end":"2026-09-15T22:20:02.751452Z","steps":["trace[115721566] 'read index received' (duration: 190.018702ms)","trace[115721566] 'applied index is now lower than readState.Index' (duration: 10.045019ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:20:02.751652Z","caller":"traceutil/trace.go:171","msg":"trace[554294395] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"217.076403ms","start":"2026-09-15T22:20:02.53452Z","end":"2026-09-15T22:20:02.751596Z","steps":["trace[554294395] 'process raft request' (duration: 216.545151ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:20:02.751699Z","caller":"traceutil/trace.go:171","msg":"trace[527368887] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"211.719777ms","start":"2026-09-15T22:20:02.539958Z","end":"2026-09-15T22:20:02.751678Z","steps":["trace[527368887] 'process raft request' (duration: 211.270235ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:20:02.751757Z","caller":"traceutil/trace.go:171","msg":"trace[1329455242] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"115.376354ms","start":"2026-09-15T22:20:02.636367Z","end":"2026-09-15T22:20:02.751744Z","steps":["trace[1329455242] 'process raft request' (duration: 115.011752ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:20:02.751804Z","caller":"traceutil/trace.go:171","msg":"trace[1160928224] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"214.289749ms","start":"2026-09-15T22:20:02.53749Z","end":"2026-09-15T22:20:02.75178Z","steps":["trace[1160928224] 'process raft request' (duration: 213.643016ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:20:02.751708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.288402ms","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-15T22:20:02.752096Z","caller":"traceutil/trace.go:171","msg":"trace[1117532611] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:565; }","duration":"200.699254ms","start":"2026-09-15T22:20:02.551357Z","end":"2026-09-15T22:20:02.752056Z","steps":["trace[1117532611] 'agreement among raft nodes before linearized reading' (duration: 200.237582ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:20:08.85964Z","caller":"traceutil/trace.go:171","msg":"trace[2103424183] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"107.646656ms","start":"2026-09-15T22:20:08.751959Z","end":"2026-09-15T22:20:08.859606Z","steps":["trace[2103424183] 'process raft request' (duration: 107.202064ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:20:09.24782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.754089ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T22:20:09.248027Z","caller":"traceutil/trace.go:171","msg":"trace[124044813] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:670; }","duration":"379.472271ms","start":"2026-09-15T22:20:08.868531Z","end":"2026-09-15T22:20:09.248003Z","steps":["trace[124044813] 'read index received' (duration: 10.548561ms)","trace[124044813] 'applied index is now lower than readState.Index' (duration: 368.92263ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T22:20:09.248204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.666452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T22:20:09.248241Z","caller":"traceutil/trace.go:171","msg":"trace[1397125367] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:647; }","duration":"379.731383ms","start":"2026-09-15T22:20:08.868496Z","end":"2026-09-15T22:20:09.248227Z","steps":["trace[1397125367] 'agreement among raft nodes before linearized reading' (duration: 379.576842ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:20:09.24828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:20:08.86846Z","time spent":"379.809613ms","remote":"127.0.0.1:43814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-09-15T22:20:09.248264Z","caller":"traceutil/trace.go:171","msg":"trace[1184598576] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"381.652131ms","start":"2026-09-15T22:20:08.866563Z","end":"2026-09-15T22:20:09.248216Z","steps":["trace[1184598576] 'process raft request' (duration: 381.372779ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:20:09.248363Z","caller":"traceutil/trace.go:171","msg":"trace[1974454753] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"381.970682ms","start":"2026-09-15T22:20:08.866376Z","end":"2026-09-15T22:20:09.248347Z","steps":["trace[1974454753] 'process raft request' (duration: 112.333279ms)","trace[1974454753] 'compare' (duration: 268.550749ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T22:20:09.248455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:20:08.866364Z","time spent":"382.063023ms","remote":"127.0.0.1:43834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T22:20:09.248505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:20:08.866553Z","time spent":"381.825561ms","remote":"127.0.0.1:43834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T22:20:09.731316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.159842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8mlv7\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-15T22:20:09.731432Z","caller":"traceutil/trace.go:171","msg":"trace[960196182] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8mlv7; range_end:; response_count:1; response_revision:647; }","duration":"338.353542ms","start":"2026-09-15T22:20:09.393055Z","end":"2026-09-15T22:20:09.731408Z","steps":["trace[960196182] 'range keys from in-memory index tree' (duration: 337.91672ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:20:09.731613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:20:09.393025Z","time spent":"338.533054ms","remote":"127.0.0.1:43794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-8mlv7\" "} {"level":"info","ts":"2026-09-15T22:20:09.907986Z","caller":"traceutil/trace.go:171","msg":"trace[2034149574] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"194.509523ms","start":"2026-09-15T22:20:09.713447Z","end":"2026-09-15T22:20:09.907956Z","steps":["trace[2034149574] 'process raft request' (duration: 191.599548ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:20:09.915944Z","caller":"traceutil/trace.go:171","msg":"trace[1782641828] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:672; }","duration":"120.875639ms","start":"2026-09-15T22:20:09.795031Z","end":"2026-09-15T22:20:09.915907Z","steps":["trace[1782641828] 'read index received' (duration: 106.447541ms)","trace[1782641828] 'applied index is now lower than readState.Index' (duration: 14.426178ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:20:09.916031Z","caller":"traceutil/trace.go:171","msg":"trace[2103877217] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"163.772655ms","start":"2026-09-15T22:20:09.752216Z","end":"2026-09-15T22:20:09.915989Z","steps":["trace[2103877217] 'process raft request' (duration: 163.467623ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:20:09.916228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.166321ms","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-15T22:20:09.916284Z","caller":"traceutil/trace.go:171","msg":"trace[1768104611] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:649; }","duration":"121.308232ms","start":"2026-09-15T22:20:09.794955Z","end":"2026-09-15T22:20:09.916264Z","steps":["trace[1768104611] 'agreement among raft nodes before linearized reading' (duration: 121.086501ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:20:25.072223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.571688ms","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-15T22:20:25.072344Z","caller":"traceutil/trace.go:171","msg":"trace[1060050246] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:809; }","duration":"114.75121ms","start":"2026-09-15T22:20:24.957556Z","end":"2026-09-15T22:20:25.072307Z","steps":["trace[1060050246] 'range keys from in-memory index tree' (duration: 114.329918ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:20:25.247953Z","caller":"traceutil/trace.go:171","msg":"trace[1890875013] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"169.440071ms","start":"2026-09-15T22:20:25.078482Z","end":"2026-09-15T22:20:25.247923Z","steps":["trace[1890875013] 'process raft request' (duration: 169.25136ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:20:58.329738Z","caller":"traceutil/trace.go:171","msg":"trace[800073736] linearizableReadLoop","detail":"{readStateIndex:1268; appliedIndex:1267; }","duration":"133.717281ms","start":"2026-09-15T22:20:58.195986Z","end":"2026-09-15T22:20:58.329703Z","steps":["trace[800073736] 'read index received' (duration: 128.711817ms)","trace[800073736] 'applied index is now lower than readState.Index' (duration: 5.003724ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T22:20:58.330053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.037192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-15T22:20:58.330179Z","caller":"traceutil/trace.go:171","msg":"trace[1902073090] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1229; }","duration":"134.208233ms","start":"2026-09-15T22:20:58.195929Z","end":"2026-09-15T22:20:58.330137Z","steps":["trace[1902073090] 'agreement among raft nodes before linearized reading' (duration: 133.912961ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:21:40.574632Z","caller":"traceutil/trace.go:171","msg":"trace[440475957] transaction","detail":"{read_only:false; response_revision:1776; number_of_response:1; }","duration":"101.011244ms","start":"2026-09-15T22:21:40.47359Z","end":"2026-09-15T22:21:40.574601Z","steps":["trace[440475957] 'process raft request' (duration: 99.720758ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:21:52.124869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.092889ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T22:21:52.125049Z","caller":"traceutil/trace.go:171","msg":"trace[191497648] linearizableReadLoop","detail":"{readStateIndex:1992; appliedIndex:1991; }","duration":"349.40836ms","start":"2026-09-15T22:21:51.775625Z","end":"2026-09-15T22:21:52.125033Z","steps":["trace[191497648] 'read index received' (duration: 18.631238ms)","trace[191497648] 'applied index is now lower than readState.Index' (duration: 330.775682ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:21:52.125158Z","caller":"traceutil/trace.go:171","msg":"trace[455364916] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"388.936939ms","start":"2026-09-15T22:21:51.736103Z","end":"2026-09-15T22:21:52.12504Z","steps":["trace[455364916] 'process raft request' (duration: 58.199817ms)","trace[455364916] 'compare' (duration: 329.816728ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T22:21:52.125449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.920248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"warn","ts":"2026-09-15T22:21:52.125477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:21:51.736049Z","time spent":"389.21848ms","remote":"127.0.0.1:43834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T22:21:52.125774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.138635ms","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-15T22:21:52.125764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.765978ms","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-15T22:21:52.125825Z","caller":"traceutil/trace.go:171","msg":"trace[1926093272] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1916; }","duration":"327.208085ms","start":"2026-09-15T22:21:51.7986Z","end":"2026-09-15T22:21:52.125808Z","steps":["trace[1926093272] 'agreement among raft nodes before linearized reading' (duration: 326.927174ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:21:52.125852Z","caller":"traceutil/trace.go:171","msg":"trace[28952513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1916; }","duration":"305.06907ms","start":"2026-09-15T22:21:51.820759Z","end":"2026-09-15T22:21:52.125828Z","steps":["trace[28952513] 'agreement among raft nodes before linearized reading' (duration: 304.563477ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:21:52.125871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:21:51.798591Z","time spent":"327.274255ms","remote":"127.0.0.1:43834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-15T22:21:52.125908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:21:51.820753Z","time spent":"305.14603ms","remote":"127.0.0.1:43834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-15T22:21:52.125533Z","caller":"traceutil/trace.go:171","msg":"trace[528092597] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1916; }","duration":"334.060558ms","start":"2026-09-15T22:21:51.79146Z","end":"2026-09-15T22:21:52.125521Z","steps":["trace[528092597] 'agreement among raft nodes before linearized reading' (duration: 333.786826ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:21:52.126295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:21:51.79143Z","time spent":"334.853102ms","remote":"127.0.0.1:43834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-09-15T22:21:52.126388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.80187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-09-15T22:21:52.12544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.788913ms","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-15T22:21:52.126517Z","caller":"traceutil/trace.go:171","msg":"trace[618727324] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1916; }","duration":"350.940098ms","start":"2026-09-15T22:21:51.775562Z","end":"2026-09-15T22:21:52.126502Z","steps":["trace[618727324] 'agreement among raft nodes before linearized reading' (duration: 349.668971ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:21:52.126519Z","caller":"traceutil/trace.go:171","msg":"trace[1365225946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1916; }","duration":"251.028231ms","start":"2026-09-15T22:21:51.875466Z","end":"2026-09-15T22:21:52.126494Z","steps":["trace[1365225946] 'agreement among raft nodes before linearized reading' (duration: 249.986236ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:21:52.125466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.073198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6886b0cb-18f2-46c6-bb46-90a9225d43b8\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-15T22:21:52.126685Z","caller":"traceutil/trace.go:171","msg":"trace[410499115] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6886b0cb-18f2-46c6-bb46-90a9225d43b8; range_end:; response_count:1; response_revision:1916; }","duration":"178.306613ms","start":"2026-09-15T22:21:51.948332Z","end":"2026-09-15T22:21:52.126639Z","steps":["trace[410499115] 'agreement among raft nodes before linearized reading' (duration: 176.939676ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:21:52.126608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:21:51.775529Z","time spent":"351.063978ms","remote":"127.0.0.1:43834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-15T22:21:52.444609Z","caller":"traceutil/trace.go:171","msg":"trace[429156018] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"312.055672ms","start":"2026-09-15T22:21:52.132526Z","end":"2026-09-15T22:21:52.444581Z","steps":["trace[429156018] 'process raft request' (duration: 311.824921ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:21:52.444928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:21:52.132501Z","time spent":"312.286624ms","remote":"127.0.0.1:43834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T22:21:52.445192Z","caller":"traceutil/trace.go:171","msg":"trace[608596602] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"312.599146ms","start":"2026-09-15T22:21:52.13258Z","end":"2026-09-15T22:21:52.445179Z","steps":["trace[608596602] 'process raft request' (duration: 311.941652ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:21:52.44531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:21:52.132553Z","time spent":"312.716976ms","remote":"127.0.0.1:43834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T22:21:52.446109Z","caller":"traceutil/trace.go:171","msg":"trace[1186999138] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"313.42766ms","start":"2026-09-15T22:21:52.132658Z","end":"2026-09-15T22:21:52.446086Z","steps":["trace[1186999138] 'process raft request' (duration: 312.476515ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:21:52.446275Z","caller":"traceutil/trace.go:171","msg":"trace[156215216] transaction","detail":"{read_only:false; response_revision:1922; number_of_response:1; }","duration":"309.741342ms","start":"2026-09-15T22:21:52.13642Z","end":"2026-09-15T22:21:52.446161Z","steps":["trace[156215216] 'process raft request' (duration: 309.576021ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:21:52.446376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:21:52.136405Z","time spent":"309.927283ms","remote":"127.0.0.1:43794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T22:21:52.446621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:21:52.13265Z","time spent":"313.56878ms","remote":"127.0.0.1:43834","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-15T22:21:52.446906Z","caller":"traceutil/trace.go:171","msg":"trace[886165276] transaction","detail":"{read_only:false; response_revision:1921; number_of_response:1; }","duration":"313.043326ms","start":"2026-09-15T22:21:52.133828Z","end":"2026-09-15T22:21:52.446872Z","steps":["trace[886165276] 'process raft request' (duration: 312.048982ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:21:52.44717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:21:52.133818Z","time spent":"313.184037ms","remote":"127.0.0.1:43834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T22:21:52.591402Z","caller":"traceutil/trace.go:171","msg":"trace[2035939224] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"325.644017ms","start":"2026-09-15T22:21:52.265703Z","end":"2026-09-15T22:21:52.591347Z","steps":["trace[2035939224] 'process raft request' (duration: 315.065487ms)","trace[2035939224] 'compare' (duration: 10.224399ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T22:21:52.591762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:21:52.265669Z","time spent":"325.811168ms","remote":"127.0.0.1:43834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T22:22:05.106378Z","caller":"traceutil/trace.go:171","msg":"trace[48066174] transaction","detail":"{read_only:false; response_revision:2035; number_of_response:1; }","duration":"214.612836ms","start":"2026-09-15T22:22:04.891719Z","end":"2026-09-15T22:22:05.106331Z","steps":["trace[48066174] 'process raft request' (duration: 165.531242ms)","trace[48066174] 'compare' (duration: 48.723432ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T22:22:08.682931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.529671ms","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-15T22:22:08.683062Z","caller":"traceutil/trace.go:171","msg":"trace[1348099999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2050; }","duration":"376.715241ms","start":"2026-09-15T22:22:08.306325Z","end":"2026-09-15T22:22:08.683041Z","steps":["trace[1348099999] 'range keys from in-memory index tree' (duration: 376.305899ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:22:08.683115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:22:08.306302Z","time spent":"376.798002ms","remote":"127.0.0.1:43834","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-15T22:22:08.683174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.367099ms","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-15T22:22:08.683228Z","caller":"traceutil/trace.go:171","msg":"trace[1455907402] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2051; }","duration":"129.462529ms","start":"2026-09-15T22:22:08.553751Z","end":"2026-09-15T22:22:08.683214Z","steps":["trace[1455907402] 'agreement among raft nodes before linearized reading' (duration: 129.266658ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:22:08.682957Z","caller":"traceutil/trace.go:171","msg":"trace[1394484797] linearizableReadLoop","detail":"{readStateIndex:2131; appliedIndex:2130; }","duration":"129.126818ms","start":"2026-09-15T22:22:08.5538Z","end":"2026-09-15T22:22:08.682927Z","steps":["trace[1394484797] 'read index received' (duration: 125.847772ms)","trace[1394484797] 'applied index is now lower than readState.Index' (duration: 3.277346ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:22:08.68354Z","caller":"traceutil/trace.go:171","msg":"trace[287284936] transaction","detail":"{read_only:false; response_revision:2051; number_of_response:1; }","duration":"246.978051ms","start":"2026-09-15T22:22:08.43652Z","end":"2026-09-15T22:22:08.683498Z","steps":["trace[287284936] 'process raft request' (duration: 243.111843ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:22:08.699618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.204225ms","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-15T22:22:08.699743Z","caller":"traceutil/trace.go:171","msg":"trace[232723651] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2052; }","duration":"145.394065ms","start":"2026-09-15T22:22:08.554323Z","end":"2026-09-15T22:22:08.699717Z","steps":["trace[232723651] 'agreement among raft nodes before linearized reading' (duration: 145.106174ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:22:08.69984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.25582ms","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-15T22:22:08.699951Z","caller":"traceutil/trace.go:171","msg":"trace[2083059141] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2052; }","duration":"144.45089ms","start":"2026-09-15T22:22:08.555476Z","end":"2026-09-15T22:22:08.699927Z","steps":["trace[2083059141] 'agreement among raft nodes before linearized reading' (duration: 144.026988ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:22:31.330805Z","caller":"traceutil/trace.go:171","msg":"trace[1767914164] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"106.76373ms","start":"2026-09-15T22:22:31.224009Z","end":"2026-09-15T22:22:31.330773Z","steps":["trace[1767914164] 'process raft request' (duration: 106.581469ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:22:32.647076Z","caller":"traceutil/trace.go:171","msg":"trace[1388467992] linearizableReadLoop","detail":"{readStateIndex:2268; appliedIndex:2267; }","duration":"202.075287ms","start":"2026-09-15T22:22:32.444977Z","end":"2026-09-15T22:22:32.647052Z","steps":["trace[1388467992] 'read index received' (duration: 201.923666ms)","trace[1388467992] 'applied index is now lower than readState.Index' (duration: 150.731µs)"],"step_count":2} {"level":"warn","ts":"2026-09-15T22:22:32.647326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.336348ms","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-15T22:22:32.647267Z","caller":"traceutil/trace.go:171","msg":"trace[387788563] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"357.992453ms","start":"2026-09-15T22:22:32.289112Z","end":"2026-09-15T22:22:32.647104Z","steps":["trace[387788563] 'process raft request' (duration: 357.794692ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:22:32.647361Z","caller":"traceutil/trace.go:171","msg":"trace[1037922885] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2183; }","duration":"202.432488ms","start":"2026-09-15T22:22:32.444918Z","end":"2026-09-15T22:22:32.647351Z","steps":["trace[1037922885] 'agreement among raft nodes before linearized reading' (duration: 202.271167ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:22:32.647465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.785895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T22:22:32.647532Z","caller":"traceutil/trace.go:171","msg":"trace[2004145357] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:2183; }","duration":"153.930017ms","start":"2026-09-15T22:22:32.493587Z","end":"2026-09-15T22:22:32.647517Z","steps":["trace[2004145357] 'agreement among raft nodes before linearized reading' (duration: 153.805916ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:22:32.64754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:22:32.289085Z","time spent":"358.298314ms","remote":"127.0.0.1:43834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T22:22:32.894485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.125362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-15T22:22:32.894587Z","caller":"traceutil/trace.go:171","msg":"trace[134097628] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:2183; }","duration":"161.274022ms","start":"2026-09-15T22:22:32.733286Z","end":"2026-09-15T22:22:32.89456Z","steps":["trace[134097628] 'count revisions from in-memory index tree' (duration: 161.018199ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:22:33.183617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.757928ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T22:22:33.183823Z","caller":"traceutil/trace.go:171","msg":"trace[1387332136] linearizableReadLoop","detail":"{readStateIndex:2273; appliedIndex:2269; }","duration":"208.605687ms","start":"2026-09-15T22:22:32.9752Z","end":"2026-09-15T22:22:33.183806Z","steps":["trace[1387332136] 'read index received' (duration: 7.868507ms)","trace[1387332136] 'applied index is now lower than readState.Index' (duration: 200.73612ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:22:33.184015Z","caller":"traceutil/trace.go:171","msg":"trace[302804718] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"284.047728ms","start":"2026-09-15T22:22:32.899943Z","end":"2026-09-15T22:22:33.183991Z","steps":["trace[302804718] 'process raft request' (duration: 99.826728ms)","trace[302804718] 'compare' (duration: 183.201306ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:22:33.184088Z","caller":"traceutil/trace.go:171","msg":"trace[749811475] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"283.774147ms","start":"2026-09-15T22:22:32.900301Z","end":"2026-09-15T22:22:33.184075Z","steps":["trace[749811475] 'process raft request' (duration: 283.400026ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:22:33.18401Z","caller":"traceutil/trace.go:171","msg":"trace[1370293737] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"283.334875ms","start":"2026-09-15T22:22:32.900641Z","end":"2026-09-15T22:22:33.183976Z","steps":["trace[1370293737] 'process raft request' (duration: 283.126644ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:22:33.184223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.982241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T22:22:33.184282Z","caller":"traceutil/trace.go:171","msg":"trace[1607424123] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2188; }","duration":"151.085082ms","start":"2026-09-15T22:22:33.033183Z","end":"2026-09-15T22:22:33.184268Z","steps":["trace[1607424123] 'agreement among raft nodes before linearized reading' (duration: 150.815741ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:22:33.18446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.253231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.119\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-15T22:22:33.184508Z","caller":"traceutil/trace.go:171","msg":"trace[1613371363] range","detail":"{range_begin:/registry/masterleases/162.253.55.119; range_end:; response_count:1; response_revision:2188; }","duration":"209.331721ms","start":"2026-09-15T22:22:32.975163Z","end":"2026-09-15T22:22:33.184494Z","steps":["trace[1613371363] 'agreement among raft nodes before linearized reading' (duration: 209.17735ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:23:35.375244Z","caller":"traceutil/trace.go:171","msg":"trace[2084248538] transaction","detail":"{read_only:false; response_revision:2625; number_of_response:1; }","duration":"100.091239ms","start":"2026-09-15T22:23:35.275102Z","end":"2026-09-15T22:23:35.375194Z","steps":["trace[2084248538] 'process raft request' (duration: 99.861618ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:23:59.202226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.089084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T22:23:59.202323Z","caller":"traceutil/trace.go:171","msg":"trace[1395491186] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2757; }","duration":"170.256004ms","start":"2026-09-15T22:23:59.03205Z","end":"2026-09-15T22:23:59.202306Z","steps":["trace[1395491186] 'range keys from in-memory index tree' (duration: 170.009794ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:24:09.823117Z","caller":"traceutil/trace.go:171","msg":"trace[2032456555] transaction","detail":"{read_only:false; response_revision:2814; number_of_response:1; }","duration":"106.74079ms","start":"2026-09-15T22:24:09.716344Z","end":"2026-09-15T22:24:09.823085Z","steps":["trace[2032456555] 'process raft request' (duration: 106.045907ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:24:09.933255Z","caller":"traceutil/trace.go:171","msg":"trace[1293653579] transaction","detail":"{read_only:false; response_revision:2815; number_of_response:1; }","duration":"105.653554ms","start":"2026-09-15T22:24:09.827562Z","end":"2026-09-15T22:24:09.933215Z","steps":["trace[1293653579] 'process raft request' (duration: 67.239572ms)","trace[1293653579] 'compare' (duration: 38.090391ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:24:09.933325Z","caller":"traceutil/trace.go:171","msg":"trace[662923567] transaction","detail":"{read_only:false; response_revision:2816; number_of_response:1; }","duration":"104.961802ms","start":"2026-09-15T22:24:09.828307Z","end":"2026-09-15T22:24:09.933269Z","steps":["trace[662923567] 'process raft request' (duration: 104.733591ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:24:09.933604Z","caller":"traceutil/trace.go:171","msg":"trace[1620427280] transaction","detail":"{read_only:false; response_revision:2818; number_of_response:1; }","duration":"104.276798ms","start":"2026-09-15T22:24:09.829314Z","end":"2026-09-15T22:24:09.933591Z","steps":["trace[1620427280] 'process raft request' (duration: 104.175978ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:24:09.933595Z","caller":"traceutil/trace.go:171","msg":"trace[139147508] transaction","detail":"{read_only:false; response_revision:2817; number_of_response:1; }","duration":"105.132592ms","start":"2026-09-15T22:24:09.82841Z","end":"2026-09-15T22:24:09.933543Z","steps":["trace[139147508] 'process raft request' (duration: 104.67281ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:24:10.291332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.473491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T22:24:10.291415Z","caller":"traceutil/trace.go:171","msg":"trace[863228059] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2818; }","duration":"257.582022ms","start":"2026-09-15T22:24:10.033808Z","end":"2026-09-15T22:24:10.29139Z","steps":["trace[863228059] 'range keys from in-memory index tree' (duration: 257.401571ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:24:10.607937Z","caller":"traceutil/trace.go:171","msg":"trace[2021568159] transaction","detail":"{read_only:false; response_revision:2819; number_of_response:1; }","duration":"305.947513ms","start":"2026-09-15T22:24:10.301961Z","end":"2026-09-15T22:24:10.607908Z","steps":["trace[2021568159] 'process raft request' (duration: 305.718912ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:24:10.608359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:24:10.301936Z","time spent":"306.302665ms","remote":"127.0.0.1:43834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T22:28:36.115401Z","caller":"traceutil/trace.go:171","msg":"trace[265079342] transaction","detail":"{read_only:false; response_revision:4774; number_of_response:1; }","duration":"105.023803ms","start":"2026-09-15T22:28:36.010351Z","end":"2026-09-15T22:28:36.115375Z","steps":["trace[265079342] 'process raft request' (duration: 85.57508ms)","trace[265079342] 'compare' (duration: 19.143531ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:28:36.418677Z","caller":"traceutil/trace.go:171","msg":"trace[1951452501] linearizableReadLoop","detail":"{readStateIndex:4961; appliedIndex:4960; }","duration":"208.407457ms","start":"2026-09-15T22:28:36.210206Z","end":"2026-09-15T22:28:36.418614Z","steps":["trace[1951452501] 'read index received' (duration: 108.826601ms)","trace[1951452501] 'applied index is now lower than readState.Index' (duration: 99.579316ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:28:36.41873Z","caller":"traceutil/trace.go:171","msg":"trace[781573310] transaction","detail":"{read_only:false; response_revision:4776; number_of_response:1; }","duration":"214.531257ms","start":"2026-09-15T22:28:36.204164Z","end":"2026-09-15T22:28:36.418696Z","steps":["trace[781573310] 'process raft request' (duration: 114.857589ms)","trace[781573310] 'compare' (duration: 99.314736ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T22:28:36.41905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.82395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-tls\" ","response":"range_response_count:1 size:3226"} {"level":"info","ts":"2026-09-15T22:28:36.419161Z","caller":"traceutil/trace.go:171","msg":"trace[592803767] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-tls; range_end:; response_count:1; response_revision:4776; }","duration":"208.94702ms","start":"2026-09-15T22:28:36.210151Z","end":"2026-09-15T22:28:36.419098Z","steps":["trace[592803767] 'agreement among raft nodes before linearized reading' (duration: 208.633929ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:28:36.421211Z","caller":"traceutil/trace.go:171","msg":"trace[226823146] transaction","detail":"{read_only:false; response_revision:4777; number_of_response:1; }","duration":"104.35254ms","start":"2026-09-15T22:28:36.316842Z","end":"2026-09-15T22:28:36.421195Z","steps":["trace[226823146] 'process raft request' (duration: 104.238199ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:28:36.453341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.258033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/grafana-tls-tkj5v\" ","response":"range_response_count:1 size:2444"} {"level":"info","ts":"2026-09-15T22:28:36.453438Z","caller":"traceutil/trace.go:171","msg":"trace[114029350] range","detail":"{range_begin:/registry/secrets/monitoring/grafana-tls-tkj5v; range_end:; response_count:1; response_revision:4780; }","duration":"199.394123ms","start":"2026-09-15T22:28:36.254021Z","end":"2026-09-15T22:28:36.453415Z","steps":["trace[114029350] 'agreement among raft nodes before linearized reading' (duration: 199.147212ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:28:36.454002Z","caller":"traceutil/trace.go:171","msg":"trace[806885436] transaction","detail":"{read_only:false; response_revision:4778; number_of_response:1; }","duration":"129.308129ms","start":"2026-09-15T22:28:36.324674Z","end":"2026-09-15T22:28:36.453982Z","steps":["trace[806885436] 'process raft request' (duration: 128.187764ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:28:36.454174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.422296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-15T22:28:36.454289Z","caller":"traceutil/trace.go:171","msg":"trace[434694644] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:4780; }","duration":"118.570737ms","start":"2026-09-15T22:28:36.335701Z","end":"2026-09-15T22:28:36.454272Z","steps":["trace[434694644] 'agreement among raft nodes before linearized reading' (duration: 118.408226ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:28:40.816654Z","caller":"traceutil/trace.go:171","msg":"trace[826029760] linearizableReadLoop","detail":"{readStateIndex:5083; appliedIndex:5082; }","duration":"140.480782ms","start":"2026-09-15T22:28:40.676146Z","end":"2026-09-15T22:28:40.816627Z","steps":["trace[826029760] 'read index received' (duration: 140.427082ms)","trace[826029760] 'applied index is now lower than readState.Index' (duration: 52.41µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:28:40.816775Z","caller":"traceutil/trace.go:171","msg":"trace[1315762212] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"140.614552ms","start":"2026-09-15T22:28:40.676088Z","end":"2026-09-15T22:28:40.816703Z","steps":["trace[1315762212] 'process raft request' (duration: 140.369511ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:28:40.816965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.797283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:7465"} {"level":"info","ts":"2026-09-15T22:28:40.817004Z","caller":"traceutil/trace.go:171","msg":"trace[654729289] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4896; }","duration":"140.888364ms","start":"2026-09-15T22:28:40.676104Z","end":"2026-09-15T22:28:40.816993Z","steps":["trace[654729289] 'agreement among raft nodes before linearized reading' (duration: 140.669123ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:28:48.262338Z","caller":"traceutil/trace.go:171","msg":"trace[2062296030] transaction","detail":"{read_only:false; response_revision:5070; number_of_response:1; }","duration":"189.423736ms","start":"2026-09-15T22:28:48.072875Z","end":"2026-09-15T22:28:48.262299Z","steps":["trace[2062296030] 'process raft request' (duration: 162.207695ms)","trace[2062296030] 'compare' (duration: 26.90898ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:28:48.296711Z","caller":"traceutil/trace.go:171","msg":"trace[1933229490] transaction","detail":"{read_only:false; response_revision:5071; number_of_response:1; }","duration":"122.202745ms","start":"2026-09-15T22:28:48.174473Z","end":"2026-09-15T22:28:48.296676Z","steps":["trace[1933229490] 'process raft request' (duration: 122.049344ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:28:48.657604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.034446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-09-15T22:28:48.657685Z","caller":"traceutil/trace.go:171","msg":"trace[1683680794] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5074; }","duration":"158.225557ms","start":"2026-09-15T22:28:48.499439Z","end":"2026-09-15T22:28:48.657664Z","steps":["trace[1683680794] 'range keys from in-memory index tree' (duration: 157.839416ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:28:48.657808Z","caller":"traceutil/trace.go:171","msg":"trace[1755957274] transaction","detail":"{read_only:false; response_revision:5075; number_of_response:1; }","duration":"142.551722ms","start":"2026-09-15T22:28:48.515172Z","end":"2026-09-15T22:28:48.657724Z","steps":["trace[1755957274] 'process raft request' (duration: 120.436846ms)","trace[1755957274] 'compare' (duration: 21.850405ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:28:48.819678Z","caller":"traceutil/trace.go:171","msg":"trace[312403934] transaction","detail":"{read_only:false; response_revision:5076; number_of_response:1; }","duration":"157.256183ms","start":"2026-09-15T22:28:48.662395Z","end":"2026-09-15T22:28:48.819651Z","steps":["trace[312403934] 'process raft request' (duration: 157.091133ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:28:52.417307Z","caller":"traceutil/trace.go:171","msg":"trace[347515766] transaction","detail":"{read_only:false; response_revision:5130; number_of_response:1; }","duration":"108.332898ms","start":"2026-09-15T22:28:52.308932Z","end":"2026-09-15T22:28:52.417265Z","steps":["trace[347515766] 'process raft request' (duration: 108.182818ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:29:02.653448Z","caller":"traceutil/trace.go:171","msg":"trace[1215531314] linearizableReadLoop","detail":"{readStateIndex:5450; appliedIndex:5449; }","duration":"432.84779ms","start":"2026-09-15T22:29:02.220566Z","end":"2026-09-15T22:29:02.653414Z","steps":["trace[1215531314] 'read index received' (duration: 432.642549ms)","trace[1215531314] 'applied index is now lower than readState.Index' (duration: 204.031µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:29:02.653484Z","caller":"traceutil/trace.go:171","msg":"trace[1360174245] transaction","detail":"{read_only:false; response_revision:5253; number_of_response:1; }","duration":"435.307541ms","start":"2026-09-15T22:29:02.218149Z","end":"2026-09-15T22:29:02.653457Z","steps":["trace[1360174245] 'process raft request' (duration: 435.02807ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:29:02.653718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:29:02.218132Z","time spent":"435.505452ms","remote":"127.0.0.1:43794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10667,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T22:29:02.653718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.128341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-b073ec7c-acc6-446b-9c1b-9ade1df56878\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-09-15T22:29:02.653787Z","caller":"traceutil/trace.go:171","msg":"trace[1192155223] range","detail":"{range_begin:/registry/persistentvolumes/pvc-b073ec7c-acc6-446b-9c1b-9ade1df56878; range_end:; response_count:1; response_revision:5253; }","duration":"433.212982ms","start":"2026-09-15T22:29:02.220551Z","end":"2026-09-15T22:29:02.653764Z","steps":["trace[1192155223] 'agreement among raft nodes before linearized reading' (duration: 433.004611ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:29:02.65385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:29:02.220488Z","time spent":"433.346913ms","remote":"127.0.0.1:43764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1345,"request content":"key:\"/registry/persistentvolumes/pvc-b073ec7c-acc6-446b-9c1b-9ade1df56878\" "} {"level":"info","ts":"2026-09-15T22:29:02.661356Z","caller":"traceutil/trace.go:171","msg":"trace[873062100] transaction","detail":"{read_only:false; response_revision:5254; number_of_response:1; }","duration":"191.908419ms","start":"2026-09-15T22:29:02.469424Z","end":"2026-09-15T22:29:02.661333Z","steps":["trace[873062100] 'process raft request' (duration: 191.215405ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:29:02.772517Z","caller":"traceutil/trace.go:171","msg":"trace[1137007379] transaction","detail":"{read_only:false; response_revision:5255; number_of_response:1; }","duration":"108.128376ms","start":"2026-09-15T22:29:02.664352Z","end":"2026-09-15T22:29:02.77248Z","steps":["trace[1137007379] 'process raft request' (duration: 79.002607ms)","trace[1137007379] 'compare' (duration: 28.975869ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:29:02.787984Z","caller":"traceutil/trace.go:171","msg":"trace[1819323215] transaction","detail":"{read_only:false; response_revision:5256; number_of_response:1; }","duration":"123.543151ms","start":"2026-09-15T22:29:02.66441Z","end":"2026-09-15T22:29:02.787953Z","steps":["trace[1819323215] 'process raft request' (duration: 123.28611ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:29:02.788503Z","caller":"traceutil/trace.go:171","msg":"trace[1071311974] transaction","detail":"{read_only:false; response_revision:5257; number_of_response:1; }","duration":"123.766332ms","start":"2026-09-15T22:29:02.664661Z","end":"2026-09-15T22:29:02.788427Z","steps":["trace[1071311974] 'process raft request' (duration: 123.21196ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:29:02.788862Z","caller":"traceutil/trace.go:171","msg":"trace[2031371363] transaction","detail":"{read_only:false; response_revision:5258; number_of_response:1; }","duration":"123.654401ms","start":"2026-09-15T22:29:02.665185Z","end":"2026-09-15T22:29:02.788839Z","steps":["trace[2031371363] 'process raft request' (duration: 123.298939ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:29:02.789342Z","caller":"traceutil/trace.go:171","msg":"trace[199742931] transaction","detail":"{read_only:false; response_revision:5259; number_of_response:1; }","duration":"112.541018ms","start":"2026-09-15T22:29:02.676778Z","end":"2026-09-15T22:29:02.789319Z","steps":["trace[199742931] 'process raft request' (duration: 111.836885ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:29:19.989358Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2868} {"level":"info","ts":"2026-09-15T22:29:20.146108Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2868,"took":"155.527573ms","hash":3103444651,"current-db-size-bytes":52281344,"current-db-size":"52 MB","current-db-size-in-use-bytes":27607040,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-15T22:29:20.146229Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3103444651,"revision":2868,"compact-revision":-1} {"level":"info","ts":"2026-09-15T22:29:51.116765Z","caller":"traceutil/trace.go:171","msg":"trace[1930622884] linearizableReadLoop","detail":"{readStateIndex:5860; appliedIndex:5859; }","duration":"151.041633ms","start":"2026-09-15T22:29:50.965651Z","end":"2026-09-15T22:29:51.116693Z","steps":["trace[1930622884] 'read index received' (duration: 150.785632ms)","trace[1930622884] 'applied index is now lower than readState.Index' (duration: 254.351µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:29:51.116853Z","caller":"traceutil/trace.go:171","msg":"trace[771806391] transaction","detail":"{read_only:false; response_revision:5651; number_of_response:1; }","duration":"162.377696ms","start":"2026-09-15T22:29:50.954417Z","end":"2026-09-15T22:29:51.116795Z","steps":["trace[771806391] 'process raft request' (duration: 162.014535ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:29:51.117667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.345384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T22:29:51.117774Z","caller":"traceutil/trace.go:171","msg":"trace[897613340] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:5651; }","duration":"152.158077ms","start":"2026-09-15T22:29:50.96559Z","end":"2026-09-15T22:29:51.117748Z","steps":["trace[897613340] 'agreement among raft nodes before linearized reading' (duration: 151.311104ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:30:50.443632Z","caller":"traceutil/trace.go:171","msg":"trace[252511103] transaction","detail":"{read_only:false; response_revision:6089; number_of_response:1; }","duration":"113.394863ms","start":"2026-09-15T22:30:50.330208Z","end":"2026-09-15T22:30:50.443602Z","steps":["trace[252511103] 'process raft request' (duration: 103.908848ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:32:57.166257Z","caller":"traceutil/trace.go:171","msg":"trace[1257262403] transaction","detail":"{read_only:false; response_revision:6935; number_of_response:1; }","duration":"119.371855ms","start":"2026-09-15T22:32:57.0468Z","end":"2026-09-15T22:32:57.166172Z","steps":["trace[1257262403] 'process raft request' (duration: 119.062671ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:32:57.931605Z","caller":"traceutil/trace.go:171","msg":"trace[757018907] transaction","detail":"{read_only:false; response_revision:6940; number_of_response:1; }","duration":"105.194346ms","start":"2026-09-15T22:32:57.826374Z","end":"2026-09-15T22:32:57.931569Z","steps":["trace[757018907] 'process raft request' (duration: 78.079165ms)","trace[757018907] 'compare' (duration: 26.807967ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:33:16.114568Z","caller":"traceutil/trace.go:171","msg":"trace[295972996] transaction","detail":"{read_only:false; response_revision:7086; number_of_response:1; }","duration":"128.85318ms","start":"2026-09-15T22:33:15.985695Z","end":"2026-09-15T22:33:16.114549Z","steps":["trace[295972996] 'process raft request' (duration: 128.733651ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:34:19.995635Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5374} {"level":"info","ts":"2026-09-15T22:34:20.088133Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5374,"took":"91.17708ms","hash":2152252802,"current-db-size-bytes":52281344,"current-db-size":"52 MB","current-db-size-in-use-bytes":18919424,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-15T22:34:20.088206Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2152252802,"revision":5374,"compact-revision":2868}