{"level":"warn","ts":"2026-02-26T03:12:14.12938Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-26T03:12:14.12949Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.12: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.12:2380","--initial-cluster=instance=https://162.253.55.12:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.12:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.12: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-02-26T03:12:14.129572Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-26T03:12:14.129588Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.12:2380"]} {"level":"info","ts":"2026-02-26T03:12:14.129612Z","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-02-26T03:12:14.130953Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.12:2379"]} {"level":"info","ts":"2026-02-26T03:12:14.131191Z","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":16,"max-cpu-available":16,"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.12:2380"],"listen-peer-urls":["https://162.253.55.12:2380"],"advertise-client-urls":["https://162.253.55.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.12: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-02-26T03:12:14.136425Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.059541ms"} {"level":"info","ts":"2026-02-26T03:12:14.144651Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b4c6dc24a78438ca","cluster-id":"587227f9a3f73e98"} {"level":"info","ts":"2026-02-26T03:12:14.144795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca switched to configuration voters=()"} {"level":"info","ts":"2026-02-26T03:12:14.144839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became follower at term 0"} {"level":"info","ts":"2026-02-26T03:12:14.144908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b4c6dc24a78438ca [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-26T03:12:14.144993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became follower at term 1"} {"level":"info","ts":"2026-02-26T03:12:14.145095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca switched to configuration voters=(13026341022203132106)"} {"level":"warn","ts":"2026-02-26T03:12:14.155622Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-26T03:12:14.157322Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-26T03:12:14.158726Z","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-02-26T03:12:14.161394Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b4c6dc24a78438ca","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-26T03:12:14.161527Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b4c6dc24a78438ca","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-26T03:12:14.161679Z","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-02-26T03:12:14.161872Z","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-02-26T03:12:14.1619Z","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-02-26T03:12:14.162507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca switched to configuration voters=(13026341022203132106)"} {"level":"info","ts":"2026-02-26T03:12:14.163225Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"587227f9a3f73e98","local-member-id":"b4c6dc24a78438ca","added-peer-id":"b4c6dc24a78438ca","added-peer-peer-urls":["https://162.253.55.12:2380"]} {"level":"info","ts":"2026-02-26T03:12:14.166492Z","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-02-26T03:12:14.166894Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b4c6dc24a78438ca","initial-advertise-peer-urls":["https://162.253.55.12:2380"],"listen-peer-urls":["https://162.253.55.12:2380"],"advertise-client-urls":["https://162.253.55.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-26T03:12:14.166935Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-26T03:12:14.167907Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.12:2380"} {"level":"info","ts":"2026-02-26T03:12:14.167958Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.12:2380"} {"level":"info","ts":"2026-02-26T03:12:14.245945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca is starting a new election at term 1"} {"level":"info","ts":"2026-02-26T03:12:14.246003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became pre-candidate at term 1"} {"level":"info","ts":"2026-02-26T03:12:14.246067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca received MsgPreVoteResp from b4c6dc24a78438ca at term 1"} {"level":"info","ts":"2026-02-26T03:12:14.246105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became candidate at term 2"} {"level":"info","ts":"2026-02-26T03:12:14.246129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca received MsgVoteResp from b4c6dc24a78438ca at term 2"} {"level":"info","ts":"2026-02-26T03:12:14.246154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b4c6dc24a78438ca became leader at term 2"} {"level":"info","ts":"2026-02-26T03:12:14.24618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b4c6dc24a78438ca elected leader b4c6dc24a78438ca at term 2"} {"level":"info","ts":"2026-02-26T03:12:14.247206Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b4c6dc24a78438ca","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.12:2379]}","request-path":"/0/members/b4c6dc24a78438ca/attributes","cluster-id":"587227f9a3f73e98","publish-timeout":"7s"} {"level":"info","ts":"2026-02-26T03:12:14.247241Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T03:12:14.24739Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-26T03:12:14.247582Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-26T03:12:14.247684Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-26T03:12:14.250996Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-26T03:12:14.256695Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T03:12:14.258705Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.12:2379"} {"level":"info","ts":"2026-02-26T03:12:14.259871Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"587227f9a3f73e98","local-member-id":"b4c6dc24a78438ca","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T03:12:14.26009Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T03:12:14.260123Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-26T03:12:22.209772Z","caller":"traceutil/trace.go:171","msg":"trace[1778555979] linearizableReadLoop","detail":"{readStateIndex:345; appliedIndex:344; }","duration":"270.311763ms","start":"2026-02-26T03:12:21.939427Z","end":"2026-02-26T03:12:22.209739Z","steps":["trace[1778555979] 'read index received' (duration: 270.151089ms)","trace[1778555979] 'applied index is now lower than readState.Index' (duration: 159.534µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:12:22.209821Z","caller":"traceutil/trace.go:171","msg":"trace[25773338] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"382.564969ms","start":"2026-02-26T03:12:21.827206Z","end":"2026-02-26T03:12:22.209771Z","steps":["trace[25773338] 'process raft request' (duration: 382.336473ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:12:22.209984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.540879ms","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-02-26T03:12:22.210112Z","caller":"traceutil/trace.go:171","msg":"trace[122997925] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:333; }","duration":"270.725464ms","start":"2026-02-26T03:12:21.939371Z","end":"2026-02-26T03:12:22.210096Z","steps":["trace[122997925] 'agreement among raft nodes before linearized reading' (duration: 270.503747ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:12:22.210548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:12:21.827189Z","time spent":"382.749914ms","remote":"127.0.0.1:58910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-26T03:12:22.647489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.381974ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T03:12:22.647602Z","caller":"traceutil/trace.go:171","msg":"trace[2062954834] linearizableReadLoop","detail":"{readStateIndex:346; appliedIndex:345; }","duration":"431.291799ms","start":"2026-02-26T03:12:22.216293Z","end":"2026-02-26T03:12:22.647585Z","steps":["trace[2062954834] 'read index received' (duration: 255.442002ms)","trace[2062954834] 'applied index is now lower than readState.Index' (duration: 175.848407ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:12:22.647638Z","caller":"traceutil/trace.go:171","msg":"trace[822420201] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"432.956736ms","start":"2026-02-26T03:12:22.214652Z","end":"2026-02-26T03:12:22.647609Z","steps":["trace[822420201] 'process raft request' (duration: 257.089748ms)","trace[822420201] 'compare' (duration: 175.254561ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:12:22.64774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.438343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"warn","ts":"2026-02-26T03:12:22.64777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:12:22.214624Z","time spent":"433.079699ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T03:12:22.647798Z","caller":"traceutil/trace.go:171","msg":"trace[174016683] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:334; }","duration":"431.520275ms","start":"2026-02-26T03:12:22.216265Z","end":"2026-02-26T03:12:22.647785Z","steps":["trace[174016683] 'agreement among raft nodes before linearized reading' (duration: 431.414293ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:12:22.647852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:12:22.216254Z","time spent":"431.587327ms","remote":"127.0.0.1:58910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":239,"request content":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" "} {"level":"warn","ts":"2026-02-26T03:12:22.647894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.763318ms","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-02-26T03:12:22.647917Z","caller":"traceutil/trace.go:171","msg":"trace[515741236] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:334; }","duration":"353.807209ms","start":"2026-02-26T03:12:22.294102Z","end":"2026-02-26T03:12:22.647909Z","steps":["trace[515741236] 'agreement among raft nodes before linearized reading' (duration: 353.760177ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:12:22.647936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:12:22.294088Z","time spent":"353.84365ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-26T03:12:22.647997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.245652ms","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-02-26T03:12:22.648018Z","caller":"traceutil/trace.go:171","msg":"trace[1598472233] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:334; }","duration":"162.265792ms","start":"2026-02-26T03:12:22.485747Z","end":"2026-02-26T03:12:22.648013Z","steps":["trace[1598472233] 'agreement among raft nodes before linearized reading' (duration: 162.233791ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:12:23.081085Z","caller":"traceutil/trace.go:171","msg":"trace[1264252860] linearizableReadLoop","detail":"{readStateIndex:348; appliedIndex:346; }","duration":"429.102841ms","start":"2026-02-26T03:12:22.651963Z","end":"2026-02-26T03:12:23.081066Z","steps":["trace[1264252860] 'read index received' (duration: 382.931131ms)","trace[1264252860] 'applied index is now lower than readState.Index' (duration: 46.17096ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:12:23.081459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.271697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-02-26T03:12:23.081499Z","caller":"traceutil/trace.go:171","msg":"trace[286664048] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:336; }","duration":"428.340029ms","start":"2026-02-26T03:12:22.653144Z","end":"2026-02-26T03:12:23.081484Z","steps":["trace[286664048] 'agreement among raft nodes before linearized reading' (duration: 428.270267ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:12:23.081526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:12:22.653133Z","time spent":"428.38629ms","remote":"127.0.0.1:58910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":239,"request content":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" "} {"level":"info","ts":"2026-02-26T03:12:23.081476Z","caller":"traceutil/trace.go:171","msg":"trace[2115357892] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"429.7643ms","start":"2026-02-26T03:12:22.651667Z","end":"2026-02-26T03:12:23.081432Z","steps":["trace[2115357892] 'process raft request' (duration: 383.21266ms)","trace[2115357892] 'compare' (duration: 46.057407ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:12:23.081495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.479051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:12:23.082166Z","caller":"traceutil/trace.go:171","msg":"trace[426722640] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:0; response_revision:336; }","duration":"430.216031ms","start":"2026-02-26T03:12:22.651925Z","end":"2026-02-26T03:12:23.082141Z","steps":["trace[426722640] 'agreement among raft nodes before linearized reading' (duration: 429.43659ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:12:23.081562Z","caller":"traceutil/trace.go:171","msg":"trace[1232299840] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"429.614054ms","start":"2026-02-26T03:12:22.651908Z","end":"2026-02-26T03:12:23.081522Z","steps":["trace[1232299840] 'process raft request' (duration: 429.129251ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:12:23.082255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:12:22.651901Z","time spent":"430.334094ms","remote":"127.0.0.1:58910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-02-26T03:12:23.08236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:12:22.651892Z","time spent":"430.381346ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T03:12:23.081671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:12:22.651582Z","time spent":"430.002397ms","remote":"127.0.0.1:53574","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-02-26T03:12:23.08173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.416864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T03:12:23.082815Z","caller":"traceutil/trace.go:171","msg":"trace[1939122268] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:336; }","duration":"412.574116ms","start":"2026-02-26T03:12:22.670223Z","end":"2026-02-26T03:12:23.082797Z","steps":["trace[1939122268] 'agreement among raft nodes before linearized reading' (duration: 411.370964ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:12:23.082876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:12:22.670196Z","time spent":"412.664368ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-26T03:12:43.600886Z","caller":"traceutil/trace.go:171","msg":"trace[623530241] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"377.591814ms","start":"2026-02-26T03:12:43.223266Z","end":"2026-02-26T03:12:43.600857Z","steps":["trace[623530241] 'process raft request' (duration: 309.237754ms)","trace[623530241] 'compare' (duration: 68.254398ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:12:43.60104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:12:43.223247Z","time spent":"377.716687ms","remote":"127.0.0.1:53574","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-02-26T03:12:49.365432Z","caller":"traceutil/trace.go:171","msg":"trace[658630045] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"156.35004ms","start":"2026-02-26T03:12:49.209041Z","end":"2026-02-26T03:12:49.365391Z","steps":["trace[658630045] 'process raft request' (duration: 70.996673ms)","trace[658630045] 'compare' (duration: 85.1118ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:12:49.822799Z","caller":"traceutil/trace.go:171","msg":"trace[1536005599] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"195.431555ms","start":"2026-02-26T03:12:49.627331Z","end":"2026-02-26T03:12:49.822762Z","steps":["trace[1536005599] 'process raft request' (duration: 195.24183ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:13:15.727491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.59131ms","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-02-26T03:13:15.727624Z","caller":"traceutil/trace.go:171","msg":"trace[1298637729] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:940; }","duration":"235.784715ms","start":"2026-02-26T03:13:15.491818Z","end":"2026-02-26T03:13:15.727603Z","steps":["trace[1298637729] 'range keys from in-memory index tree' (duration: 235.364855ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:00.49228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.602754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9ba4d44b-a738-4fd1-88d4-51dbb32d9d39\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-02-26T03:14:00.492279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.027126ms","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-02-26T03:14:00.492401Z","caller":"traceutil/trace.go:171","msg":"trace[1105943649] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9ba4d44b-a738-4fd1-88d4-51dbb32d9d39; range_end:; response_count:1; response_revision:1589; }","duration":"214.789269ms","start":"2026-02-26T03:14:00.277583Z","end":"2026-02-26T03:14:00.492372Z","steps":["trace[1105943649] 'range keys from in-memory index tree' (duration: 214.386589ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:14:00.492423Z","caller":"traceutil/trace.go:171","msg":"trace[1510728146] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1589; }","duration":"273.240371ms","start":"2026-02-26T03:14:00.219155Z","end":"2026-02-26T03:14:00.492396Z","steps":["trace[1510728146] 'range keys from in-memory index tree' (duration: 272.793859ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:00.492939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.229321ms","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-02-26T03:14:00.493006Z","caller":"traceutil/trace.go:171","msg":"trace[11082075] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1589; }","duration":"276.346993ms","start":"2026-02-26T03:14:00.216638Z","end":"2026-02-26T03:14:00.492985Z","steps":["trace[11082075] 'range keys from in-memory index tree' (duration: 275.362898ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:01.153562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.301124ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T03:14:01.153677Z","caller":"traceutil/trace.go:171","msg":"trace[1956390867] linearizableReadLoop","detail":"{readStateIndex:1659; appliedIndex:1658; }","duration":"232.994988ms","start":"2026-02-26T03:14:00.920668Z","end":"2026-02-26T03:14:01.153663Z","steps":["trace[1956390867] 'read index received' (duration: 52.341µs)","trace[1956390867] 'applied index is now lower than readState.Index' (duration: 232.941707ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:14:01.153786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.885511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:14:01.153817Z","caller":"traceutil/trace.go:171","msg":"trace[1994140460] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1598; }","duration":"167.957743ms","start":"2026-02-26T03:14:00.985851Z","end":"2026-02-26T03:14:01.153809Z","steps":["trace[1994140460] 'agreement among raft nodes before linearized reading' (duration: 167.902271ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:01.153831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.139152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T03:14:01.153843Z","caller":"traceutil/trace.go:171","msg":"trace[1883933212] transaction","detail":"{read_only:false; response_revision:1598; number_of_response:1; }","duration":"368.68628ms","start":"2026-02-26T03:14:00.785066Z","end":"2026-02-26T03:14:01.153752Z","steps":["trace[1883933212] 'process raft request' (duration: 57.119068ms)","trace[1883933212] 'compare' (duration: 311.204462ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:14:01.153934Z","caller":"traceutil/trace.go:171","msg":"trace[1484361686] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1598; }","duration":"233.294416ms","start":"2026-02-26T03:14:00.92061Z","end":"2026-02-26T03:14:01.153904Z","steps":["trace[1484361686] 'agreement among raft nodes before linearized reading' (duration: 233.117672ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:01.154193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:00.785038Z","time spent":"369.018329ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T03:14:13.842818Z","caller":"traceutil/trace.go:171","msg":"trace[943699381] transaction","detail":"{read_only:false; response_revision:1696; number_of_response:1; }","duration":"134.561041ms","start":"2026-02-26T03:14:13.708224Z","end":"2026-02-26T03:14:13.842785Z","steps":["trace[943699381] 'process raft request' (duration: 92.401138ms)","trace[943699381] 'compare' (duration: 41.708862ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:14:18.019439Z","caller":"traceutil/trace.go:171","msg":"trace[1957780555] transaction","detail":"{read_only:false; response_revision:1723; number_of_response:1; }","duration":"370.932539ms","start":"2026-02-26T03:14:17.648464Z","end":"2026-02-26T03:14:18.019397Z","steps":["trace[1957780555] 'process raft request' (duration: 367.134529ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:18.019682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:17.64844Z","time spent":"371.109664ms","remote":"127.0.0.1:58720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T03:14:18.03594Z","caller":"traceutil/trace.go:171","msg":"trace[1669580403] transaction","detail":"{read_only:false; response_revision:1724; number_of_response:1; }","duration":"371.922826ms","start":"2026-02-26T03:14:17.663984Z","end":"2026-02-26T03:14:18.035907Z","steps":["trace[1669580403] 'process raft request' (duration: 371.676869ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:18.036146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:17.66396Z","time spent":"372.07658ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T03:14:18.036357Z","caller":"traceutil/trace.go:171","msg":"trace[1092086013] transaction","detail":"{read_only:false; response_revision:1725; number_of_response:1; }","duration":"344.547723ms","start":"2026-02-26T03:14:17.691781Z","end":"2026-02-26T03:14:18.036328Z","steps":["trace[1092086013] 'process raft request' (duration: 344.066981ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:18.037393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:17.691767Z","time spent":"344.656035ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T03:14:18.037775Z","caller":"traceutil/trace.go:171","msg":"trace[1172193135] linearizableReadLoop","detail":"{readStateIndex:1791; appliedIndex:1787; }","duration":"182.335051ms","start":"2026-02-26T03:14:17.855351Z","end":"2026-02-26T03:14:18.037686Z","steps":["trace[1172193135] 'read index received' (duration: 160.423204ms)","trace[1172193135] 'applied index is now lower than readState.Index' (duration: 21.862636ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:14:18.0381Z","caller":"traceutil/trace.go:171","msg":"trace[829681736] transaction","detail":"{read_only:false; response_revision:1726; number_of_response:1; }","duration":"323.523297ms","start":"2026-02-26T03:14:17.714517Z","end":"2026-02-26T03:14:18.03804Z","steps":["trace[829681736] 'process raft request' (duration: 321.785891ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:18.038458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:17.714503Z","time spent":"323.783074ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T03:14:18.038583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.093091ms","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-02-26T03:14:18.038714Z","caller":"traceutil/trace.go:171","msg":"trace[1752974568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1726; }","duration":"183.378749ms","start":"2026-02-26T03:14:17.855303Z","end":"2026-02-26T03:14:18.038682Z","steps":["trace[1752974568] 'agreement among raft nodes before linearized reading' (duration: 182.788514ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:14:30.934362Z","caller":"traceutil/trace.go:171","msg":"trace[899557967] transaction","detail":"{read_only:false; response_revision:1787; number_of_response:1; }","duration":"126.230131ms","start":"2026-02-26T03:14:30.808105Z","end":"2026-02-26T03:14:30.934335Z","steps":["trace[899557967] 'process raft request' (duration: 126.047946ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:14:31.041709Z","caller":"traceutil/trace.go:171","msg":"trace[1417464104] transaction","detail":"{read_only:false; response_revision:1788; number_of_response:1; }","duration":"130.924355ms","start":"2026-02-26T03:14:30.910748Z","end":"2026-02-26T03:14:31.041673Z","steps":["trace[1417464104] 'process raft request' (duration: 96.150577ms)","trace[1417464104] 'compare' (duration: 34.626774ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:14:31.636758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.098106ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T03:14:31.636876Z","caller":"traceutil/trace.go:171","msg":"trace[180493970] linearizableReadLoop","detail":"{readStateIndex:1861; appliedIndex:1860; }","duration":"100.77548ms","start":"2026-02-26T03:14:31.536082Z","end":"2026-02-26T03:14:31.636858Z","steps":["trace[180493970] 'read index received' (duration: 43.572µs)","trace[180493970] 'applied index is now lower than readState.Index' (duration: 100.730758ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:14:31.636966Z","caller":"traceutil/trace.go:171","msg":"trace[1689394757] transaction","detail":"{read_only:false; response_revision:1793; number_of_response:1; }","duration":"178.945582ms","start":"2026-02-26T03:14:31.457971Z","end":"2026-02-26T03:14:31.636917Z","steps":["trace[1689394757] 'process raft request' (duration: 21.60132ms)","trace[1689394757] 'compare' (duration: 156.984824ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:14:31.637005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.929674ms","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-02-26T03:14:31.637081Z","caller":"traceutil/trace.go:171","msg":"trace[27530121] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1793; }","duration":"100.999725ms","start":"2026-02-26T03:14:31.536026Z","end":"2026-02-26T03:14:31.637026Z","steps":["trace[27530121] 'agreement among raft nodes before linearized reading' (duration: 100.879192ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:14:32.356375Z","caller":"traceutil/trace.go:171","msg":"trace[1166709845] linearizableReadLoop","detail":"{readStateIndex:1865; appliedIndex:1864; }","duration":"154.470707ms","start":"2026-02-26T03:14:32.201881Z","end":"2026-02-26T03:14:32.356352Z","steps":["trace[1166709845] 'read index received' (duration: 88.025643ms)","trace[1166709845] 'applied index is now lower than readState.Index' (duration: 66.444264ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:14:32.356472Z","caller":"traceutil/trace.go:171","msg":"trace[74262254] transaction","detail":"{read_only:false; response_revision:1797; number_of_response:1; }","duration":"159.411728ms","start":"2026-02-26T03:14:32.197037Z","end":"2026-02-26T03:14:32.356448Z","steps":["trace[74262254] 'process raft request' (duration: 93.035015ms)","trace[74262254] 'compare' (duration: 66.164737ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:14:32.356666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.765884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-26T03:14:32.356701Z","caller":"traceutil/trace.go:171","msg":"trace[822084636] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1797; }","duration":"154.837396ms","start":"2026-02-26T03:14:32.201855Z","end":"2026-02-26T03:14:32.356692Z","steps":["trace[822084636] 'agreement among raft nodes before linearized reading' (duration: 154.625ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:14:32.578462Z","caller":"traceutil/trace.go:171","msg":"trace[503016856] transaction","detail":"{read_only:false; response_revision:1799; number_of_response:1; }","duration":"191.021201ms","start":"2026-02-26T03:14:32.387402Z","end":"2026-02-26T03:14:32.578423Z","steps":["trace[503016856] 'process raft request' (duration: 94.447203ms)","trace[503016856] 'compare' (duration: 96.150997ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:14:33.883987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.451536ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T03:14:33.884362Z","caller":"traceutil/trace.go:171","msg":"trace[1289182139] linearizableReadLoop","detail":"{readStateIndex:1871; appliedIndex:1870; }","duration":"206.988782ms","start":"2026-02-26T03:14:33.677343Z","end":"2026-02-26T03:14:33.884332Z","steps":["trace[1289182139] 'read index received' (duration: 60.032363ms)","trace[1289182139] 'applied index is now lower than readState.Index' (duration: 146.953629ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:14:33.88447Z","caller":"traceutil/trace.go:171","msg":"trace[362644191] transaction","detail":"{read_only:false; response_revision:1802; number_of_response:1; }","duration":"304.073234ms","start":"2026-02-26T03:14:33.580308Z","end":"2026-02-26T03:14:33.884381Z","steps":["trace[362644191] 'process raft request' (duration: 157.084785ms)","trace[362644191] 'compare' (duration: 145.768308ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:14:33.884685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.306211ms","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-02-26T03:14:33.884805Z","caller":"traceutil/trace.go:171","msg":"trace[1257781879] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1802; }","duration":"207.472555ms","start":"2026-02-26T03:14:33.677309Z","end":"2026-02-26T03:14:33.884782Z","steps":["trace[1257781879] 'agreement among raft nodes before linearized reading' (duration: 207.170186ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:33.884805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:33.580279Z","time spent":"304.321101ms","remote":"127.0.0.1:58776","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-02-26T03:14:34.408287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.18362ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T03:14:34.408672Z","caller":"traceutil/trace.go:171","msg":"trace[1131032373] transaction","detail":"{read_only:false; response_revision:1806; number_of_response:1; }","duration":"205.921915ms","start":"2026-02-26T03:14:34.202729Z","end":"2026-02-26T03:14:34.408651Z","steps":["trace[1131032373] 'process raft request' (duration: 205.807352ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:14:34.408804Z","caller":"traceutil/trace.go:171","msg":"trace[1948994566] transaction","detail":"{read_only:false; response_revision:1805; number_of_response:1; }","duration":"206.768136ms","start":"2026-02-26T03:14:34.201958Z","end":"2026-02-26T03:14:34.408726Z","steps":["trace[1948994566] 'process raft request' (duration: 83.026042ms)","trace[1948994566] 'compare' (duration: 122.916273ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:14:34.477794Z","caller":"traceutil/trace.go:171","msg":"trace[1839020733] transaction","detail":"{read_only:false; response_revision:1807; number_of_response:1; }","duration":"116.008202ms","start":"2026-02-26T03:14:34.361751Z","end":"2026-02-26T03:14:34.47776Z","steps":["trace[1839020733] 'process raft request' (duration: 115.678263ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:34.675955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.834605ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T03:14:34.676157Z","caller":"traceutil/trace.go:171","msg":"trace[2089556847] transaction","detail":"{read_only:false; response_revision:1808; number_of_response:1; }","duration":"193.030004ms","start":"2026-02-26T03:14:34.483085Z","end":"2026-02-26T03:14:34.676115Z","steps":["trace[2089556847] 'process raft request' (duration: 70.948173ms)","trace[2089556847] 'compare' (duration: 121.663ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:14:35.060513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.144115ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:14:35.060716Z","caller":"traceutil/trace.go:171","msg":"trace[724458508] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1809; }","duration":"202.378252ms","start":"2026-02-26T03:14:34.85831Z","end":"2026-02-26T03:14:35.060688Z","steps":["trace[724458508] 'range keys from in-memory index tree' (duration: 202.108734ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:35.060752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.375024ms","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-02-26T03:14:35.060873Z","caller":"traceutil/trace.go:171","msg":"trace[1274751099] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1809; }","duration":"168.566989ms","start":"2026-02-26T03:14:34.892277Z","end":"2026-02-26T03:14:35.060844Z","steps":["trace[1274751099] 'range keys from in-memory index tree' (duration: 168.116887ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:35.060709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.374623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:14:35.061048Z","caller":"traceutil/trace.go:171","msg":"trace[387804288] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1809; }","duration":"254.797575ms","start":"2026-02-26T03:14:34.806216Z","end":"2026-02-26T03:14:35.061014Z","steps":["trace[387804288] 'range keys from in-memory index tree' (duration: 254.23992ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:14:36.041707Z","caller":"traceutil/trace.go:171","msg":"trace[2039355626] transaction","detail":"{read_only:false; response_revision:1812; number_of_response:1; }","duration":"128.626584ms","start":"2026-02-26T03:14:35.913059Z","end":"2026-02-26T03:14:36.041686Z","steps":["trace[2039355626] 'process raft request' (duration: 128.490241ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:36.335018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.964375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T03:14:36.335093Z","caller":"traceutil/trace.go:171","msg":"trace[1047023105] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1812; }","duration":"176.092338ms","start":"2026-02-26T03:14:36.158984Z","end":"2026-02-26T03:14:36.335077Z","steps":["trace[1047023105] 'count revisions from in-memory index tree' (duration: 175.780318ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:14:36.335269Z","caller":"traceutil/trace.go:171","msg":"trace[1419746783] transaction","detail":"{read_only:false; response_revision:1813; number_of_response:1; }","duration":"128.10947ms","start":"2026-02-26T03:14:36.207101Z","end":"2026-02-26T03:14:36.335211Z","steps":["trace[1419746783] 'process raft request' (duration: 88.438743ms)","trace[1419746783] 'compare' (duration: 39.504363ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:14:36.561427Z","caller":"traceutil/trace.go:171","msg":"trace[1751175391] transaction","detail":"{read_only:false; response_revision:1814; number_of_response:1; }","duration":"146.866836ms","start":"2026-02-26T03:14:36.414526Z","end":"2026-02-26T03:14:36.561393Z","steps":["trace[1751175391] 'process raft request' (duration: 108.985487ms)","trace[1751175391] 'compare' (duration: 37.711815ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:14:37.01561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.725325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:14:37.015724Z","caller":"traceutil/trace.go:171","msg":"trace[1644960411] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1815; }","duration":"209.92328ms","start":"2026-02-26T03:14:36.805775Z","end":"2026-02-26T03:14:37.015698Z","steps":["trace[1644960411] 'range keys from in-memory index tree' (duration: 209.609712ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:37.016338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.477923ms","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-02-26T03:14:37.016371Z","caller":"traceutil/trace.go:171","msg":"trace[1271364614] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1815; }","duration":"335.569595ms","start":"2026-02-26T03:14:36.680795Z","end":"2026-02-26T03:14:37.016365Z","steps":["trace[1271364614] 'range keys from in-memory index tree' (duration: 335.234977ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:37.016391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:36.680764Z","time spent":"335.620407ms","remote":"127.0.0.1:53574","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-02-26T03:14:37.016529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.336852ms","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-02-26T03:14:37.016634Z","caller":"traceutil/trace.go:171","msg":"trace[1914603075] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1815; }","duration":"287.529757ms","start":"2026-02-26T03:14:36.729084Z","end":"2026-02-26T03:14:37.016613Z","steps":["trace[1914603075] 'range keys from in-memory index tree' (duration: 287.033685ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:14:37.236025Z","caller":"traceutil/trace.go:171","msg":"trace[131699892] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"214.514632ms","start":"2026-02-26T03:14:37.021491Z","end":"2026-02-26T03:14:37.236005Z","steps":["trace[131699892] 'process raft request' (duration: 214.390769ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:14:37.58927Z","caller":"traceutil/trace.go:171","msg":"trace[1242630892] transaction","detail":"{read_only:false; response_revision:1817; number_of_response:1; }","duration":"567.66697ms","start":"2026-02-26T03:14:37.021577Z","end":"2026-02-26T03:14:37.589244Z","steps":["trace[1242630892] 'process raft request' (duration: 567.369503ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:14:37.589323Z","caller":"traceutil/trace.go:171","msg":"trace[186676540] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"480.054358ms","start":"2026-02-26T03:14:37.109176Z","end":"2026-02-26T03:14:37.589231Z","steps":["trace[186676540] 'process raft request' (duration: 479.919794ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:37.589449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:37.021537Z","time spent":"567.794513ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T03:14:37.589515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.991245ms","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-02-26T03:14:37.5896Z","caller":"traceutil/trace.go:171","msg":"trace[516067683] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1818; }","duration":"514.132488ms","start":"2026-02-26T03:14:37.075446Z","end":"2026-02-26T03:14:37.589578Z","steps":["trace[516067683] 'agreement among raft nodes before linearized reading' (duration: 513.898322ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:37.589633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:37.075414Z","time spent":"514.212431ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-02-26T03:14:37.589578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:37.10914Z","time spent":"480.302626ms","remote":"127.0.0.1:58776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":810,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T03:14:37.589179Z","caller":"traceutil/trace.go:171","msg":"trace[2066211809] linearizableReadLoop","detail":"{readStateIndex:1886; appliedIndex:1885; }","duration":"513.646995ms","start":"2026-02-26T03:14:37.075505Z","end":"2026-02-26T03:14:37.589152Z","steps":["trace[2066211809] 'read index received' (duration: 160.453405ms)","trace[2066211809] 'applied index is now lower than readState.Index' (duration: 353.19203ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:14:37.589859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.300687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T03:14:37.589922Z","caller":"traceutil/trace.go:171","msg":"trace[1085131883] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1818; }","duration":"446.41263ms","start":"2026-02-26T03:14:37.143481Z","end":"2026-02-26T03:14:37.589894Z","steps":["trace[1085131883] 'agreement among raft nodes before linearized reading' (duration: 446.289087ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:37.58995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:37.143454Z","time spent":"446.489571ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T03:14:37.590111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.470335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.12\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-26T03:14:37.590145Z","caller":"traceutil/trace.go:171","msg":"trace[2067489155] range","detail":"{range_begin:/registry/masterleases/162.253.55.12; range_end:; response_count:1; response_revision:1818; }","duration":"179.545268ms","start":"2026-02-26T03:14:37.410591Z","end":"2026-02-26T03:14:37.590137Z","steps":["trace[2067489155] 'agreement among raft nodes before linearized reading' (duration: 179.410414ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:38.170471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.439287ms","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-02-26T03:14:38.170543Z","caller":"traceutil/trace.go:171","msg":"trace[1250255795] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1822; }","duration":"123.579962ms","start":"2026-02-26T03:14:38.046948Z","end":"2026-02-26T03:14:38.170528Z","steps":["trace[1250255795] 'range keys from in-memory index tree' (duration: 123.14732ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:14:38.398734Z","caller":"traceutil/trace.go:171","msg":"trace[837317748] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"124.824834ms","start":"2026-02-26T03:14:38.273886Z","end":"2026-02-26T03:14:38.398711Z","steps":["trace[837317748] 'process raft request' (duration: 124.68383ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:38.696625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.780816ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T03:14:38.696873Z","caller":"traceutil/trace.go:171","msg":"trace[1181552613] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"128.230754ms","start":"2026-02-26T03:14:38.568607Z","end":"2026-02-26T03:14:38.696838Z","steps":["trace[1181552613] 'process raft request' (duration: 128.181173ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:14:38.697029Z","caller":"traceutil/trace.go:171","msg":"trace[1796468373] transaction","detail":"{read_only:false; response_revision:1826; number_of_response:1; }","duration":"130.911314ms","start":"2026-02-26T03:14:38.566109Z","end":"2026-02-26T03:14:38.69702Z","steps":["trace[1796468373] 'process raft request' (duration: 17.665446ms)","trace[1796468373] 'compare' (duration: 112.663813ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:14:38.697117Z","caller":"traceutil/trace.go:171","msg":"trace[566590511] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"128.974714ms","start":"2026-02-26T03:14:38.568108Z","end":"2026-02-26T03:14:38.697083Z","steps":["trace[566590511] 'process raft request' (duration: 128.620394ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:14:38.697146Z","caller":"traceutil/trace.go:171","msg":"trace[1072014591] linearizableReadLoop","detail":"{readStateIndex:1896; appliedIndex:1895; }","duration":"129.349823ms","start":"2026-02-26T03:14:38.56771Z","end":"2026-02-26T03:14:38.69706Z","steps":["trace[1072014591] 'read index received' (duration: 16.083404ms)","trace[1072014591] 'applied index is now lower than readState.Index' (duration: 113.255699ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:14:38.697347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.631891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.1897ad6e83cd34ba\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-02-26T03:14:38.69739Z","caller":"traceutil/trace.go:171","msg":"trace[868178691] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.1897ad6e83cd34ba; range_end:; response_count:1; response_revision:1828; }","duration":"129.726443ms","start":"2026-02-26T03:14:38.56765Z","end":"2026-02-26T03:14:38.697376Z","steps":["trace[868178691] 'agreement among raft nodes before linearized reading' (duration: 129.58571ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:38.697561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.329308ms","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-02-26T03:14:38.697636Z","caller":"traceutil/trace.go:171","msg":"trace[1408458582] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1828; }","duration":"100.476441ms","start":"2026-02-26T03:14:38.597134Z","end":"2026-02-26T03:14:38.69761Z","steps":["trace[1408458582] 'agreement among raft nodes before linearized reading' (duration: 100.196584ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:14:38.89498Z","caller":"traceutil/trace.go:171","msg":"trace[750133773] linearizableReadLoop","detail":"{readStateIndex:1899; appliedIndex:1898; }","duration":"167.822188ms","start":"2026-02-26T03:14:38.727138Z","end":"2026-02-26T03:14:38.894961Z","steps":["trace[750133773] 'read index received' (duration: 167.646164ms)","trace[750133773] 'applied index is now lower than readState.Index' (duration: 175.124µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:14:38.895109Z","caller":"traceutil/trace.go:171","msg":"trace[613940946] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"195.594791ms","start":"2026-02-26T03:14:38.699484Z","end":"2026-02-26T03:14:38.895079Z","steps":["trace[613940946] 'process raft request' (duration: 195.323035ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:38.895172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.035974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11988"} {"level":"info","ts":"2026-02-26T03:14:38.895204Z","caller":"traceutil/trace.go:171","msg":"trace[869981217] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1829; }","duration":"168.138068ms","start":"2026-02-26T03:14:38.727056Z","end":"2026-02-26T03:14:38.895194Z","steps":["trace[869981217] 'agreement among raft nodes before linearized reading' (duration: 167.999694ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:38.895305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.216134ms","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":"info","ts":"2026-02-26T03:14:38.895353Z","caller":"traceutil/trace.go:171","msg":"trace[618711747] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1829; }","duration":"114.304666ms","start":"2026-02-26T03:14:38.781033Z","end":"2026-02-26T03:14:38.895338Z","steps":["trace[618711747] 'agreement among raft nodes before linearized reading' (duration: 114.101391ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:39.260157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.483445ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T03:14:39.260302Z","caller":"traceutil/trace.go:171","msg":"trace[166673809] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"360.624626ms","start":"2026-02-26T03:14:38.899657Z","end":"2026-02-26T03:14:39.260281Z","steps":["trace[166673809] 'process raft request' (duration: 66.918056ms)","trace[166673809] 'compare' (duration: 293.333621ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:14:39.260352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:38.89964Z","time spent":"360.691679ms","remote":"127.0.0.1:53574","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-02-26T03:14:39.338195Z","caller":"traceutil/trace.go:171","msg":"trace[414725256] linearizableReadLoop","detail":"{readStateIndex:1901; appliedIndex:1900; }","duration":"153.213673ms","start":"2026-02-26T03:14:39.18495Z","end":"2026-02-26T03:14:39.338164Z","steps":["trace[414725256] 'read index received' (duration: 152.950076ms)","trace[414725256] 'applied index is now lower than readState.Index' (duration: 262.467µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:14:39.338241Z","caller":"traceutil/trace.go:171","msg":"trace[706949081] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"431.999911ms","start":"2026-02-26T03:14:38.906206Z","end":"2026-02-26T03:14:39.338206Z","steps":["trace[706949081] 'process raft request' (duration: 431.737164ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:39.338363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.399148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12403"} {"level":"info","ts":"2026-02-26T03:14:39.338401Z","caller":"traceutil/trace.go:171","msg":"trace[329201612] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1831; }","duration":"153.494561ms","start":"2026-02-26T03:14:39.184897Z","end":"2026-02-26T03:14:39.338392Z","steps":["trace[329201612] 'agreement among raft nodes before linearized reading' (duration: 153.397889ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:39.338398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:38.906182Z","time spent":"432.141536ms","remote":"127.0.0.1:58894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12388,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T03:14:50.393324Z","caller":"traceutil/trace.go:171","msg":"trace[191838417] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"111.793769ms","start":"2026-02-26T03:14:50.281498Z","end":"2026-02-26T03:14:50.393292Z","steps":["trace[191838417] 'process raft request' (duration: 111.571834ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:14:56.911559Z","caller":"traceutil/trace.go:171","msg":"trace[457437839] linearizableReadLoop","detail":"{readStateIndex:1986; appliedIndex:1985; }","duration":"468.653248ms","start":"2026-02-26T03:14:56.442841Z","end":"2026-02-26T03:14:56.911494Z","steps":["trace[457437839] 'read index received' (duration: 468.415372ms)","trace[457437839] 'applied index is now lower than readState.Index' (duration: 236.376µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:14:56.911678Z","caller":"traceutil/trace.go:171","msg":"trace[865150094] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"484.370173ms","start":"2026-02-26T03:14:56.427259Z","end":"2026-02-26T03:14:56.911629Z","steps":["trace[865150094] 'process raft request' (duration: 484.027813ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:56.911834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.951496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T03:14:56.911885Z","caller":"traceutil/trace.go:171","msg":"trace[2039900276] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1913; }","duration":"469.063439ms","start":"2026-02-26T03:14:56.442806Z","end":"2026-02-26T03:14:56.911869Z","steps":["trace[2039900276] 'agreement among raft nodes before linearized reading' (duration: 468.928615ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:56.911936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:56.442786Z","time spent":"469.138921ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":13,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-02-26T03:14:56.91195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:56.427218Z","time spent":"484.589518ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T03:14:57.255943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.484404ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T03:14:57.256125Z","caller":"traceutil/trace.go:171","msg":"trace[24920681] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"767.25788ms","start":"2026-02-26T03:14:56.488847Z","end":"2026-02-26T03:14:57.256105Z","steps":["trace[24920681] 'process raft request' (duration: 472.495389ms)","trace[24920681] 'compare' (duration: 294.36779ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:14:57.256179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:56.488813Z","time spent":"767.344022ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T03:14:57.256327Z","caller":"traceutil/trace.go:171","msg":"trace[1778402738] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"471.112525ms","start":"2026-02-26T03:14:56.785187Z","end":"2026-02-26T03:14:57.2563Z","steps":["trace[1778402738] 'process raft request' (duration: 470.879089ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:57.256409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:56.785151Z","time spent":"471.217157ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T03:14:57.256688Z","caller":"traceutil/trace.go:171","msg":"trace[1650543474] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"325.890262ms","start":"2026-02-26T03:14:56.930788Z","end":"2026-02-26T03:14:57.256678Z","steps":["trace[1650543474] 'process raft request' (duration: 325.843531ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:57.25674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:56.930754Z","time spent":"325.960504ms","remote":"127.0.0.1:53574","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-02-26T03:14:57.256854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.983527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:14:57.256828Z","caller":"traceutil/trace.go:171","msg":"trace[186063194] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"449.016921ms","start":"2026-02-26T03:14:56.807773Z","end":"2026-02-26T03:14:57.25679Z","steps":["trace[186063194] 'process raft request' (duration: 448.473276ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:57.256895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.649662ms","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-02-26T03:14:57.256898Z","caller":"traceutil/trace.go:171","msg":"trace[855662232] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1917; }","duration":"450.069889ms","start":"2026-02-26T03:14:56.806816Z","end":"2026-02-26T03:14:57.256886Z","steps":["trace[855662232] 'agreement among raft nodes before linearized reading' (duration: 450.003427ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:14:57.256916Z","caller":"traceutil/trace.go:171","msg":"trace[178166120] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1917; }","duration":"409.705924ms","start":"2026-02-26T03:14:56.847203Z","end":"2026-02-26T03:14:57.256909Z","steps":["trace[178166120] 'agreement among raft nodes before linearized reading' (duration: 409.598031ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:57.256934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:56.847178Z","time spent":"409.751894ms","remote":"127.0.0.1:43666","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-02-26T03:14:57.256938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:56.806791Z","time spent":"450.139881ms","remote":"127.0.0.1:58690","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-02-26T03:14:57.256876Z","caller":"traceutil/trace.go:171","msg":"trace[1065803385] linearizableReadLoop","detail":"{readStateIndex:1989; appliedIndex:1986; }","duration":"345.109428ms","start":"2026-02-26T03:14:56.911697Z","end":"2026-02-26T03:14:57.256807Z","steps":["trace[1065803385] 'read index received' (duration: 49.66464ms)","trace[1065803385] 'applied index is now lower than readState.Index' (duration: 295.434068ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:14:57.257012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:56.807757Z","time spent":"449.156825ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T03:14:57.257144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"814.237339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:14:57.257174Z","caller":"traceutil/trace.go:171","msg":"trace[1890980925] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:1917; }","duration":"814.307851ms","start":"2026-02-26T03:14:56.442858Z","end":"2026-02-26T03:14:57.257166Z","steps":["trace[1890980925] 'agreement among raft nodes before linearized reading' (duration: 814.26219ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:57.257195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:56.442829Z","time spent":"814.361464ms","remote":"127.0.0.1:43438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-26T03:14:57.756808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.909257ms","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-02-26T03:14:57.756935Z","caller":"traceutil/trace.go:171","msg":"trace[574523260] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1917; }","duration":"263.103542ms","start":"2026-02-26T03:14:57.493806Z","end":"2026-02-26T03:14:57.75691Z","steps":["trace[574523260] 'range keys from in-memory index tree' (duration: 262.695082ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:57.756985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.775299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.12\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-26T03:14:57.757024Z","caller":"traceutil/trace.go:171","msg":"trace[1579474727] range","detail":"{range_begin:/registry/masterleases/162.253.55.12; range_end:; response_count:1; response_revision:1917; }","duration":"344.854971ms","start":"2026-02-26T03:14:57.412157Z","end":"2026-02-26T03:14:57.757012Z","steps":["trace[1579474727] 'range keys from in-memory index tree' (duration: 344.561383ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:14:57.757051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:14:57.412131Z","time spent":"344.912642ms","remote":"127.0.0.1:58720","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.12\" "} {"level":"info","ts":"2026-02-26T03:16:01.676734Z","caller":"traceutil/trace.go:171","msg":"trace[625977244] transaction","detail":"{read_only:false; response_revision:2400; number_of_response:1; }","duration":"178.305062ms","start":"2026-02-26T03:16:01.498371Z","end":"2026-02-26T03:16:01.676676Z","steps":["trace[625977244] 'process raft request' (duration: 178.148158ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:16:01.69536Z","caller":"traceutil/trace.go:171","msg":"trace[1871472946] transaction","detail":"{read_only:false; response_revision:2402; number_of_response:1; }","duration":"160.987118ms","start":"2026-02-26T03:16:01.534349Z","end":"2026-02-26T03:16:01.695336Z","steps":["trace[1871472946] 'process raft request' (duration: 160.950178ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:16:01.695475Z","caller":"traceutil/trace.go:171","msg":"trace[419508561] transaction","detail":"{read_only:false; response_revision:2401; number_of_response:1; }","duration":"163.576216ms","start":"2026-02-26T03:16:01.531849Z","end":"2026-02-26T03:16:01.695425Z","steps":["trace[419508561] 'process raft request' (duration: 163.358829ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:16:07.887112Z","caller":"traceutil/trace.go:171","msg":"trace[446475445] transaction","detail":"{read_only:false; response_revision:2439; number_of_response:1; }","duration":"108.527431ms","start":"2026-02-26T03:16:07.778549Z","end":"2026-02-26T03:16:07.887076Z","steps":["trace[446475445] 'process raft request' (duration: 108.344716ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:16:09.716964Z","caller":"traceutil/trace.go:171","msg":"trace[1333850753] transaction","detail":"{read_only:false; response_revision:2445; number_of_response:1; }","duration":"345.699695ms","start":"2026-02-26T03:16:09.371181Z","end":"2026-02-26T03:16:09.716881Z","steps":["trace[1333850753] 'process raft request' (duration: 325.03121ms)","trace[1333850753] 'compare' (duration: 20.483481ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:16:09.717137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:16:09.37116Z","time spent":"345.892722ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T03:16:13.866279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.39991ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T03:16:13.866356Z","caller":"traceutil/trace.go:171","msg":"trace[608086825] transaction","detail":"{read_only:false; response_revision:2469; number_of_response:1; }","duration":"116.624401ms","start":"2026-02-26T03:16:13.749717Z","end":"2026-02-26T03:16:13.866342Z","steps":["trace[608086825] 'compare' (duration: 115.311438ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:16:13.890157Z","caller":"traceutil/trace.go:171","msg":"trace[109842284] transaction","detail":"{read_only:false; response_revision:2470; number_of_response:1; }","duration":"127.469163ms","start":"2026-02-26T03:16:13.76267Z","end":"2026-02-26T03:16:13.890139Z","steps":["trace[109842284] 'process raft request' (duration: 127.386081ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:16:13.896304Z","caller":"traceutil/trace.go:171","msg":"trace[86957644] transaction","detail":"{read_only:false; response_revision:2471; number_of_response:1; }","duration":"105.031031ms","start":"2026-02-26T03:16:13.791256Z","end":"2026-02-26T03:16:13.896288Z","steps":["trace[86957644] 'process raft request' (duration: 104.946299ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:16:36.656158Z","caller":"traceutil/trace.go:171","msg":"trace[1676279731] transaction","detail":"{read_only:false; response_revision:2592; number_of_response:1; }","duration":"144.762501ms","start":"2026-02-26T03:16:36.511363Z","end":"2026-02-26T03:16:36.656125Z","steps":["trace[1676279731] 'process raft request' (duration: 144.519995ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:16:36.676563Z","caller":"traceutil/trace.go:171","msg":"trace[351720185] linearizableReadLoop","detail":"{readStateIndex:2693; appliedIndex:2691; }","duration":"141.745972ms","start":"2026-02-26T03:16:36.534768Z","end":"2026-02-26T03:16:36.676514Z","steps":["trace[351720185] 'read index received' (duration: 121.145849ms)","trace[351720185] 'applied index is now lower than readState.Index' (duration: 20.598603ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:16:36.67667Z","caller":"traceutil/trace.go:171","msg":"trace[623871387] transaction","detail":"{read_only:false; response_revision:2593; number_of_response:1; }","duration":"165.147649ms","start":"2026-02-26T03:16:36.511483Z","end":"2026-02-26T03:16:36.67663Z","steps":["trace[623871387] 'process raft request' (duration: 164.855412ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:16:36.676985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.184893ms","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-02-26T03:16:36.677902Z","caller":"traceutil/trace.go:171","msg":"trace[94154741] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2593; }","duration":"143.149759ms","start":"2026-02-26T03:16:36.534737Z","end":"2026-02-26T03:16:36.677887Z","steps":["trace[94154741] 'agreement among raft nodes before linearized reading' (duration: 142.02129ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:16:36.67734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.804614ms","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-02-26T03:16:36.678394Z","caller":"traceutil/trace.go:171","msg":"trace[1575618350] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2593; }","duration":"142.872641ms","start":"2026-02-26T03:16:36.535505Z","end":"2026-02-26T03:16:36.678377Z","steps":["trace[1575618350] 'agreement among raft nodes before linearized reading' (duration: 141.711461ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:20:17.574945Z","caller":"traceutil/trace.go:171","msg":"trace[1469258823] transaction","detail":"{read_only:false; response_revision:4341; number_of_response:1; }","duration":"157.096059ms","start":"2026-02-26T03:20:17.417803Z","end":"2026-02-26T03:20:17.574899Z","steps":["trace[1469258823] 'process raft request' (duration: 108.288568ms)","trace[1469258823] 'compare' (duration: 48.02224ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:20:17.578252Z","caller":"traceutil/trace.go:171","msg":"trace[1883054008] linearizableReadLoop","detail":"{readStateIndex:4515; appliedIndex:4512; }","duration":"157.173029ms","start":"2026-02-26T03:20:17.421063Z","end":"2026-02-26T03:20:17.578236Z","steps":["trace[1883054008] 'read index received' (duration: 105.115745ms)","trace[1883054008] 'applied index is now lower than readState.Index' (duration: 52.056064ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:20:17.578348Z","caller":"traceutil/trace.go:171","msg":"trace[1084238280] transaction","detail":"{read_only:false; response_revision:4343; number_of_response:1; }","duration":"158.165696ms","start":"2026-02-26T03:20:17.420173Z","end":"2026-02-26T03:20:17.578338Z","steps":["trace[1084238280] 'process raft request' (duration: 158.009841ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:20:17.578561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.495949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-02-26T03:20:17.578596Z","caller":"traceutil/trace.go:171","msg":"trace[1692593751] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4343; }","duration":"157.54187ms","start":"2026-02-26T03:20:17.421042Z","end":"2026-02-26T03:20:17.578584Z","steps":["trace[1692593751] 'agreement among raft nodes before linearized reading' (duration: 157.384876ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:20:17.578588Z","caller":"traceutil/trace.go:171","msg":"trace[150141800] transaction","detail":"{read_only:false; response_revision:4342; number_of_response:1; }","duration":"159.121461ms","start":"2026-02-26T03:20:17.419384Z","end":"2026-02-26T03:20:17.578505Z","steps":["trace[150141800] 'process raft request' (duration: 158.7009ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:20:17.578767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.015794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.12\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-26T03:20:17.578841Z","caller":"traceutil/trace.go:171","msg":"trace[1027941549] range","detail":"{range_begin:/registry/masterleases/162.253.55.12; range_end:; response_count:1; response_revision:4343; }","duration":"148.134137ms","start":"2026-02-26T03:20:17.430686Z","end":"2026-02-26T03:20:17.578821Z","steps":["trace[1027941549] 'agreement among raft nodes before linearized reading' (duration: 147.919451ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:20:20.59279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.059166ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T03:20:20.592932Z","caller":"traceutil/trace.go:171","msg":"trace[1309986992] linearizableReadLoop","detail":"{readStateIndex:4626; appliedIndex:4625; }","duration":"135.460149ms","start":"2026-02-26T03:20:20.457454Z","end":"2026-02-26T03:20:20.592914Z","steps":["trace[1309986992] 'read index received' (duration: 33.093595ms)","trace[1309986992] 'applied index is now lower than readState.Index' (duration: 102.365204ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:20:20.592987Z","caller":"traceutil/trace.go:171","msg":"trace[1662872765] transaction","detail":"{read_only:false; response_revision:4451; number_of_response:1; }","duration":"139.664329ms","start":"2026-02-26T03:20:20.45328Z","end":"2026-02-26T03:20:20.592945Z","steps":["trace[1662872765] 'process raft request' (duration: 37.348735ms)","trace[1662872765] 'compare' (duration: 101.918403ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:20:20.593189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.740457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:9 size:72117"} {"level":"info","ts":"2026-02-26T03:20:20.593226Z","caller":"traceutil/trace.go:171","msg":"trace[1227001234] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:9; response_revision:4451; }","duration":"135.806019ms","start":"2026-02-26T03:20:20.457411Z","end":"2026-02-26T03:20:20.593217Z","steps":["trace[1227001234] 'agreement among raft nodes before linearized reading' (duration: 135.557132ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:20:27.63249Z","caller":"traceutil/trace.go:171","msg":"trace[526172871] linearizableReadLoop","detail":"{readStateIndex:4832; appliedIndex:4831; }","duration":"134.231237ms","start":"2026-02-26T03:20:27.498236Z","end":"2026-02-26T03:20:27.632467Z","steps":["trace[526172871] 'read index received' (duration: 134.091953ms)","trace[526172871] 'applied index is now lower than readState.Index' (duration: 138.014µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:20:27.632702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.458403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8467ba2a-3bcf-4620-a127-63b664ed6d0a\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-02-26T03:20:27.632741Z","caller":"traceutil/trace.go:171","msg":"trace[125971696] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8467ba2a-3bcf-4620-a127-63b664ed6d0a; range_end:; response_count:1; response_revision:4650; }","duration":"134.552435ms","start":"2026-02-26T03:20:27.498178Z","end":"2026-02-26T03:20:27.632731Z","steps":["trace[125971696] 'agreement among raft nodes before linearized reading' (duration: 134.406652ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:20:27.758819Z","caller":"traceutil/trace.go:171","msg":"trace[584542880] transaction","detail":"{read_only:false; response_revision:4651; number_of_response:1; }","duration":"125.074121ms","start":"2026-02-26T03:20:27.633709Z","end":"2026-02-26T03:20:27.758783Z","steps":["trace[584542880] 'process raft request' (duration: 117.31554ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:20:27.802643Z","caller":"traceutil/trace.go:171","msg":"trace[820963138] linearizableReadLoop","detail":"{readStateIndex:4835; appliedIndex:4832; }","duration":"123.313794ms","start":"2026-02-26T03:20:27.679306Z","end":"2026-02-26T03:20:27.802619Z","steps":["trace[820963138] 'read index received' (duration: 71.738148ms)","trace[820963138] 'applied index is now lower than readState.Index' (duration: 51.574696ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:20:27.802691Z","caller":"traceutil/trace.go:171","msg":"trace[1579343876] transaction","detail":"{read_only:false; response_revision:4652; number_of_response:1; }","duration":"163.659569ms","start":"2026-02-26T03:20:27.638999Z","end":"2026-02-26T03:20:27.802659Z","steps":["trace[1579343876] 'process raft request' (duration: 163.458624ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:20:27.802767Z","caller":"traceutil/trace.go:171","msg":"trace[1022877127] transaction","detail":"{read_only:false; response_revision:4653; number_of_response:1; }","duration":"163.64849ms","start":"2026-02-26T03:20:27.639096Z","end":"2026-02-26T03:20:27.802744Z","steps":["trace[1022877127] 'process raft request' (duration: 163.478235ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:20:27.803229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.91322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:776970"} {"level":"info","ts":"2026-02-26T03:20:27.803302Z","caller":"traceutil/trace.go:171","msg":"trace[1379370230] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4653; }","duration":"124.039304ms","start":"2026-02-26T03:20:27.679248Z","end":"2026-02-26T03:20:27.803287Z","steps":["trace[1379370230] 'agreement among raft nodes before linearized reading' (duration: 123.49605ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:20:28.213417Z","caller":"traceutil/trace.go:171","msg":"trace[431229111] transaction","detail":"{read_only:false; response_revision:4654; number_of_response:1; }","duration":"180.628629ms","start":"2026-02-26T03:20:28.032765Z","end":"2026-02-26T03:20:28.213394Z","steps":["trace[431229111] 'process raft request' (duration: 180.506116ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:20:28.224387Z","caller":"traceutil/trace.go:171","msg":"trace[2009876254] linearizableReadLoop","detail":"{readStateIndex:4837; appliedIndex:4835; }","duration":"175.739662ms","start":"2026-02-26T03:20:28.048618Z","end":"2026-02-26T03:20:28.224358Z","steps":["trace[2009876254] 'read index received' (duration: 164.729047ms)","trace[2009876254] 'applied index is now lower than readState.Index' (duration: 11.009455ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:20:28.224458Z","caller":"traceutil/trace.go:171","msg":"trace[47138522] transaction","detail":"{read_only:false; response_revision:4655; number_of_response:1; }","duration":"190.484215ms","start":"2026-02-26T03:20:28.03394Z","end":"2026-02-26T03:20:28.224424Z","steps":["trace[47138522] 'process raft request' (duration: 190.269789ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:20:28.22461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.711116ms","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-02-26T03:20:28.224647Z","caller":"traceutil/trace.go:171","msg":"trace[680971069] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4655; }","duration":"174.800858ms","start":"2026-02-26T03:20:28.049837Z","end":"2026-02-26T03:20:28.224637Z","steps":["trace[680971069] 'agreement among raft nodes before linearized reading' (duration: 174.674865ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:20:28.224648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.978839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T03:20:28.22471Z","caller":"traceutil/trace.go:171","msg":"trace[1363026321] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4655; }","duration":"176.113722ms","start":"2026-02-26T03:20:28.048584Z","end":"2026-02-26T03:20:28.224698Z","steps":["trace[1363026321] 'agreement among raft nodes before linearized reading' (duration: 175.902986ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:20:28.22473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.07116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-02-26T03:20:28.224808Z","caller":"traceutil/trace.go:171","msg":"trace[1778623493] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4655; }","duration":"103.162463ms","start":"2026-02-26T03:20:28.121629Z","end":"2026-02-26T03:20:28.224791Z","steps":["trace[1778623493] 'agreement among raft nodes before linearized reading' (duration: 102.917596ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:20:36.546102Z","caller":"traceutil/trace.go:171","msg":"trace[177652142] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"112.999787ms","start":"2026-02-26T03:20:36.43289Z","end":"2026-02-26T03:20:36.54589Z","steps":["trace[177652142] 'process raft request' (duration: 55.877088ms)","trace[177652142] 'compare' (duration: 56.798531ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:20:36.547285Z","caller":"traceutil/trace.go:171","msg":"trace[455584454] transaction","detail":"{read_only:false; response_revision:4842; number_of_response:1; }","duration":"114.025824ms","start":"2026-02-26T03:20:36.433234Z","end":"2026-02-26T03:20:36.54726Z","steps":["trace[455584454] 'process raft request' (duration: 112.519715ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:20:44.868745Z","caller":"traceutil/trace.go:171","msg":"trace[169677115] linearizableReadLoop","detail":"{readStateIndex:5207; appliedIndex:5206; }","duration":"177.979671ms","start":"2026-02-26T03:20:44.690738Z","end":"2026-02-26T03:20:44.868718Z","steps":["trace[169677115] 'read index received' (duration: 177.775325ms)","trace[169677115] 'applied index is now lower than readState.Index' (duration: 202.556µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:20:44.868872Z","caller":"traceutil/trace.go:171","msg":"trace[1472954461] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"179.326655ms","start":"2026-02-26T03:20:44.68949Z","end":"2026-02-26T03:20:44.868817Z","steps":["trace[1472954461] 'process raft request' (duration: 179.015607ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:20:44.869079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.310409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3565"} {"level":"info","ts":"2026-02-26T03:20:44.869181Z","caller":"traceutil/trace.go:171","msg":"trace[1639082437] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5015; }","duration":"178.439713ms","start":"2026-02-26T03:20:44.690715Z","end":"2026-02-26T03:20:44.869155Z","steps":["trace[1639082437] 'agreement among raft nodes before linearized reading' (duration: 178.140605ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:20:45.036749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.139504ms","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:7613"} {"level":"info","ts":"2026-02-26T03:20:45.036821Z","caller":"traceutil/trace.go:171","msg":"trace[1651185357] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5015; }","duration":"117.270879ms","start":"2026-02-26T03:20:44.919533Z","end":"2026-02-26T03:20:45.036804Z","steps":["trace[1651185357] 'range keys from in-memory index tree' (duration: 116.924739ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:20:45.126632Z","caller":"traceutil/trace.go:171","msg":"trace[740126162] transaction","detail":"{read_only:false; response_revision:5016; number_of_response:1; }","duration":"182.749974ms","start":"2026-02-26T03:20:44.94385Z","end":"2026-02-26T03:20:45.1266Z","steps":["trace[740126162] 'process raft request' (duration: 182.57505ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:20:45.482631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.813716ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T03:20:45.483063Z","caller":"traceutil/trace.go:171","msg":"trace[303512624] linearizableReadLoop","detail":"{readStateIndex:5210; appliedIndex:5207; }","duration":"458.154807ms","start":"2026-02-26T03:20:45.024882Z","end":"2026-02-26T03:20:45.483037Z","steps":["trace[303512624] 'read index received' (duration: 101.619522ms)","trace[303512624] 'applied index is now lower than readState.Index' (duration: 356.533715ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:20:45.483082Z","caller":"traceutil/trace.go:171","msg":"trace[755745480] transaction","detail":"{read_only:false; response_revision:5017; number_of_response:1; }","duration":"538.983052ms","start":"2026-02-26T03:20:44.944029Z","end":"2026-02-26T03:20:45.483012Z","steps":["trace[755745480] 'process raft request' (duration: 421.698773ms)","trace[755745480] 'compare' (duration: 116.460068ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:20:45.483554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.108831ms","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-02-26T03:20:45.483613Z","caller":"traceutil/trace.go:171","msg":"trace[650791742] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5018; }","duration":"252.202883ms","start":"2026-02-26T03:20:45.231391Z","end":"2026-02-26T03:20:45.483594Z","steps":["trace[650791742] 'agreement among raft nodes before linearized reading' (duration: 252.07216ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:20:45.483652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:20:44.94402Z","time spent":"539.457664ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T03:20:45.483157Z","caller":"traceutil/trace.go:171","msg":"trace[1712388625] transaction","detail":"{read_only:false; response_revision:5018; number_of_response:1; }","duration":"537.267466ms","start":"2026-02-26T03:20:44.945849Z","end":"2026-02-26T03:20:45.483116Z","steps":["trace[1712388625] 'process raft request' (duration: 537.01555ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:20:45.48333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.445465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kwrnr\" ","response":"range_response_count:1 size:6520"} {"level":"warn","ts":"2026-02-26T03:20:45.483989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:20:44.945838Z","time spent":"538.006296ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T03:20:45.484035Z","caller":"traceutil/trace.go:171","msg":"trace[1083854425] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kwrnr; range_end:; response_count:1; response_revision:5018; }","duration":"459.237556ms","start":"2026-02-26T03:20:45.024771Z","end":"2026-02-26T03:20:45.484009Z","steps":["trace[1083854425] 'agreement among raft nodes before linearized reading' (duration: 458.363144ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:20:45.48414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:20:45.02475Z","time spent":"459.37775ms","remote":"127.0.0.1:58894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6543,"request content":"key:\"/registry/pods/openstack/keepalived-kwrnr\" "} {"level":"warn","ts":"2026-02-26T03:20:45.484441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.26324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2209353"} {"level":"info","ts":"2026-02-26T03:20:45.484523Z","caller":"traceutil/trace.go:171","msg":"trace[229890665] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5018; }","duration":"346.344052ms","start":"2026-02-26T03:20:45.138159Z","end":"2026-02-26T03:20:45.484503Z","steps":["trace[229890665] 'agreement among raft nodes before linearized reading' (duration: 345.305716ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:20:45.484573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:20:45.138113Z","time spent":"346.444605ms","remote":"127.0.0.1:58804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":57,"response size":2209376,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"warn","ts":"2026-02-26T03:20:45.888591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.878136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T03:20:45.888703Z","caller":"traceutil/trace.go:171","msg":"trace[1625157690] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:5019; }","duration":"220.06521ms","start":"2026-02-26T03:20:45.668618Z","end":"2026-02-26T03:20:45.888683Z","steps":["trace[1625157690] 'count revisions from in-memory index tree' (duration: 219.773703ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:20:45.889266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-02-26T03:20:45.889359Z","caller":"traceutil/trace.go:171","msg":"trace[1393438841] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:5019; }","duration":"304.697953ms","start":"2026-02-26T03:20:45.584637Z","end":"2026-02-26T03:20:45.889334Z","steps":["trace[1393438841] 'range keys from in-memory index tree' (duration: 303.732838ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:20:45.889407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:20:45.584629Z","time spent":"304.767675ms","remote":"127.0.0.1:58798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":719,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" "} {"level":"info","ts":"2026-02-26T03:20:59.583126Z","caller":"traceutil/trace.go:171","msg":"trace[486457008] transaction","detail":"{read_only:false; response_revision:5198; number_of_response:1; }","duration":"141.26917ms","start":"2026-02-26T03:20:59.441831Z","end":"2026-02-26T03:20:59.5831Z","steps":["trace[486457008] 'process raft request' (duration: 141.069875ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:22:14.532162Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2782} {"level":"info","ts":"2026-02-26T03:22:14.588055Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2782,"took":"54.287678ms","hash":1920646599,"current-db-size-bytes":41037824,"current-db-size":"41 MB","current-db-size-in-use-bytes":30732288,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-02-26T03:22:14.588136Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1920646599,"revision":2782,"compact-revision":-1} {"level":"warn","ts":"2026-02-26T03:27:02.953939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.959749ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-26T03:27:02.954107Z","caller":"traceutil/trace.go:171","msg":"trace[88788719] linearizableReadLoop","detail":"{readStateIndex:8005; appliedIndex:8004; }","duration":"147.054801ms","start":"2026-02-26T03:27:02.807029Z","end":"2026-02-26T03:27:02.954084Z","steps":["trace[88788719] 'read index received' (duration: 22.006819ms)","trace[88788719] 'applied index is now lower than readState.Index' (duration: 125.046412ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:27:02.954199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.172133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:27:02.954231Z","caller":"traceutil/trace.go:171","msg":"trace[248325628] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7722; }","duration":"147.258075ms","start":"2026-02-26T03:27:02.806964Z","end":"2026-02-26T03:27:02.954222Z","steps":["trace[248325628] 'agreement among raft nodes before linearized reading' (duration: 147.181273ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:27:03.19594Z","caller":"traceutil/trace.go:171","msg":"trace[1575972346] transaction","detail":"{read_only:false; response_revision:7723; number_of_response:1; }","duration":"245.961247ms","start":"2026-02-26T03:27:02.949949Z","end":"2026-02-26T03:27:03.19591Z","steps":["trace[1575972346] 'process raft request' (duration: 245.761512ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:27:03.338637Z","caller":"traceutil/trace.go:171","msg":"trace[472062157] linearizableReadLoop","detail":"{readStateIndex:8007; appliedIndex:8005; }","duration":"383.154852ms","start":"2026-02-26T03:27:02.955457Z","end":"2026-02-26T03:27:03.338612Z","steps":["trace[472062157] 'read index received' (duration: 240.29572ms)","trace[472062157] 'applied index is now lower than readState.Index' (duration: 142.857872ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:27:03.338695Z","caller":"traceutil/trace.go:171","msg":"trace[2137894650] transaction","detail":"{read_only:false; response_revision:7724; number_of_response:1; }","duration":"387.595817ms","start":"2026-02-26T03:27:02.951045Z","end":"2026-02-26T03:27:03.338641Z","steps":["trace[2137894650] 'process raft request' (duration: 377.366233ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:27:03.338738Z","caller":"traceutil/trace.go:171","msg":"trace[1330108899] transaction","detail":"{read_only:false; response_revision:7725; number_of_response:1; }","duration":"250.76937ms","start":"2026-02-26T03:27:03.0879Z","end":"2026-02-26T03:27:03.33867Z","steps":["trace[1330108899] 'process raft request' (duration: 250.619096ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:27:03.338828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.347756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:27:03.338872Z","caller":"traceutil/trace.go:171","msg":"trace[163040544] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7725; }","duration":"383.47274ms","start":"2026-02-26T03:27:02.955386Z","end":"2026-02-26T03:27:03.338859Z","steps":["trace[163040544] 'agreement among raft nodes before linearized reading' (duration: 383.344357ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:27:03.33891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:27:02.955365Z","time spent":"383.536681ms","remote":"127.0.0.1:58694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-26T03:27:03.338912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:27:02.951019Z","time spent":"387.777201ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T03:27:04.563931Z","caller":"traceutil/trace.go:171","msg":"trace[2144676611] transaction","detail":"{read_only:false; response_revision:7728; number_of_response:1; }","duration":"113.40014ms","start":"2026-02-26T03:27:04.450502Z","end":"2026-02-26T03:27:04.563902Z","steps":["trace[2144676611] 'process raft request' (duration: 113.248036ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:27:04.579607Z","caller":"traceutil/trace.go:171","msg":"trace[1468564472] transaction","detail":"{read_only:false; response_revision:7730; number_of_response:1; }","duration":"126.911541ms","start":"2026-02-26T03:27:04.452663Z","end":"2026-02-26T03:27:04.579575Z","steps":["trace[1468564472] 'process raft request' (duration: 126.855379ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:27:04.579682Z","caller":"traceutil/trace.go:171","msg":"trace[1617241375] transaction","detail":"{read_only:false; response_revision:7729; number_of_response:1; }","duration":"128.497502ms","start":"2026-02-26T03:27:04.451147Z","end":"2026-02-26T03:27:04.579645Z","steps":["trace[1617241375] 'process raft request' (duration: 128.210574ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:27:05.574562Z","caller":"traceutil/trace.go:171","msg":"trace[760277178] linearizableReadLoop","detail":"{readStateIndex:8016; appliedIndex:8015; }","duration":"101.552584ms","start":"2026-02-26T03:27:05.472965Z","end":"2026-02-26T03:27:05.574518Z","steps":["trace[760277178] 'read index received' (duration: 57.082214ms)","trace[760277178] 'applied index is now lower than readState.Index' (duration: 44.46855ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:27:05.574598Z","caller":"traceutil/trace.go:171","msg":"trace[1844299345] transaction","detail":"{read_only:false; response_revision:7733; number_of_response:1; }","duration":"230.556079ms","start":"2026-02-26T03:27:05.343994Z","end":"2026-02-26T03:27:05.57455Z","steps":["trace[1844299345] 'process raft request' (duration: 186.076989ms)","trace[1844299345] 'compare' (duration: 44.167971ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:27:05.574887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.905523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-02-26T03:27:05.574977Z","caller":"traceutil/trace.go:171","msg":"trace[346143740] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7733; }","duration":"102.060577ms","start":"2026-02-26T03:27:05.472895Z","end":"2026-02-26T03:27:05.574955Z","steps":["trace[346143740] 'agreement among raft nodes before linearized reading' (duration: 101.7837ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:27:06.013698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.952044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-02-26T03:27:06.013846Z","caller":"traceutil/trace.go:171","msg":"trace[269023037] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7735; }","duration":"189.134798ms","start":"2026-02-26T03:27:05.824689Z","end":"2026-02-26T03:27:06.013824Z","steps":["trace[269023037] 'range keys from in-memory index tree' (duration: 188.715268ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:27:14.540223Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5765} {"level":"info","ts":"2026-02-26T03:27:14.637555Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5765,"took":"95.58958ms","hash":3562781337,"current-db-size-bytes":42668032,"current-db-size":"43 MB","current-db-size-in-use-bytes":23011328,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-02-26T03:27:14.637624Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3562781337,"revision":5765,"compact-revision":2782} {"level":"info","ts":"2026-02-26T03:27:32.899996Z","caller":"traceutil/trace.go:171","msg":"trace[2035974092] transaction","detail":"{read_only:false; response_revision:7919; number_of_response:1; }","duration":"309.220862ms","start":"2026-02-26T03:27:32.590758Z","end":"2026-02-26T03:27:32.899979Z","steps":["trace[2035974092] 'process raft request' (duration: 309.027238ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:27:32.900124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:27:32.590742Z","time spent":"309.313224ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T03:27:32.899986Z","caller":"traceutil/trace.go:171","msg":"trace[982224181] linearizableReadLoop","detail":"{readStateIndex:8210; appliedIndex:8209; }","duration":"194.063805ms","start":"2026-02-26T03:27:32.705893Z","end":"2026-02-26T03:27:32.899957Z","steps":["trace[982224181] 'read index received' (duration: 193.8527ms)","trace[982224181] 'applied index is now lower than readState.Index' (duration: 209.935µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:27:32.900347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.440225ms","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-02-26T03:27:32.900518Z","caller":"traceutil/trace.go:171","msg":"trace[1372299935] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7919; }","duration":"194.64842ms","start":"2026-02-26T03:27:32.705849Z","end":"2026-02-26T03:27:32.900498Z","steps":["trace[1372299935] 'agreement among raft nodes before linearized reading' (duration: 194.163437ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:27:32.917757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.975298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:27:32.918273Z","caller":"traceutil/trace.go:171","msg":"trace[1092279395] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7921; }","duration":"111.547802ms","start":"2026-02-26T03:27:32.806703Z","end":"2026-02-26T03:27:32.91825Z","steps":["trace[1092279395] 'agreement among raft nodes before linearized reading' (duration: 110.055984ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:27:32.918684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.651907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:27:32.91892Z","caller":"traceutil/trace.go:171","msg":"trace[1501064483] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:7921; }","duration":"149.922754ms","start":"2026-02-26T03:27:32.768974Z","end":"2026-02-26T03:27:32.918897Z","steps":["trace[1501064483] 'agreement among raft nodes before linearized reading' (duration: 147.796719ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:27:32.919108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.559977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-02-26T03:27:32.919187Z","caller":"traceutil/trace.go:171","msg":"trace[1009627875] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7921; }","duration":"211.65328ms","start":"2026-02-26T03:27:32.707516Z","end":"2026-02-26T03:27:32.919169Z","steps":["trace[1009627875] 'agreement among raft nodes before linearized reading' (duration: 209.264198ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:27:32.919392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.100281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-26T03:27:32.919425Z","caller":"traceutil/trace.go:171","msg":"trace[2120229244] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7921; }","duration":"212.144723ms","start":"2026-02-26T03:27:32.707272Z","end":"2026-02-26T03:27:32.919416Z","steps":["trace[2120229244] 'agreement among raft nodes before linearized reading' (duration: 209.516635ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:27:36.232677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.749589ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T03:27:36.232822Z","caller":"traceutil/trace.go:171","msg":"trace[1260426777] linearizableReadLoop","detail":"{readStateIndex:8227; appliedIndex:8226; }","duration":"424.886181ms","start":"2026-02-26T03:27:35.807911Z","end":"2026-02-26T03:27:36.232797Z","steps":["trace[1260426777] 'read index received' (duration: 72.886365ms)","trace[1260426777] 'applied index is now lower than readState.Index' (duration: 351.998116ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:27:36.233093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.184789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-02-26T03:27:36.233161Z","caller":"traceutil/trace.go:171","msg":"trace[1445781962] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7935; }","duration":"425.253551ms","start":"2026-02-26T03:27:35.807891Z","end":"2026-02-26T03:27:36.233144Z","steps":["trace[1445781962] 'agreement among raft nodes before linearized reading' (duration: 425.039806ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:27:36.233217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:27:35.807811Z","time spent":"425.387234ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-26T03:27:36.232885Z","caller":"traceutil/trace.go:171","msg":"trace[928884438] transaction","detail":"{read_only:false; response_revision:7935; number_of_response:1; }","duration":"438.244566ms","start":"2026-02-26T03:27:35.794567Z","end":"2026-02-26T03:27:36.232812Z","steps":["trace[928884438] 'process raft request' (duration: 86.198719ms)","trace[928884438] 'compare' (duration: 351.569345ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:27:36.233421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:27:35.794537Z","time spent":"438.750949ms","remote":"127.0.0.1:53574","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-02-26T03:27:36.233442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.277803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kwrnr\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-02-26T03:27:36.233525Z","caller":"traceutil/trace.go:171","msg":"trace[633966701] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kwrnr; range_end:; response_count:1; response_revision:7935; }","duration":"345.411386ms","start":"2026-02-26T03:27:35.888089Z","end":"2026-02-26T03:27:36.233501Z","steps":["trace[633966701] 'agreement among raft nodes before linearized reading' (duration: 345.101768ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:27:36.233572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:27:35.888063Z","time spent":"345.496468ms","remote":"127.0.0.1:58894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6543,"request content":"key:\"/registry/pods/openstack/keepalived-kwrnr\" "} {"level":"info","ts":"2026-02-26T03:27:45.999867Z","caller":"traceutil/trace.go:171","msg":"trace[758210668] transaction","detail":"{read_only:false; response_revision:8027; number_of_response:1; }","duration":"267.171484ms","start":"2026-02-26T03:27:45.73266Z","end":"2026-02-26T03:27:45.999831Z","steps":["trace[758210668] 'process raft request' (duration: 266.98477ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:27:46.236326Z","caller":"traceutil/trace.go:171","msg":"trace[1273546185] transaction","detail":"{read_only:false; response_revision:8028; number_of_response:1; }","duration":"113.990136ms","start":"2026-02-26T03:27:46.122297Z","end":"2026-02-26T03:27:46.236287Z","steps":["trace[1273546185] 'process raft request' (duration: 113.72675ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:12.416402Z","caller":"traceutil/trace.go:171","msg":"trace[1169112316] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8813; }","duration":"155.623118ms","start":"2026-02-26T03:29:12.260747Z","end":"2026-02-26T03:29:12.41637Z","steps":["trace[1169112316] 'process raft request' (duration: 155.445834ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:35.677427Z","caller":"traceutil/trace.go:171","msg":"trace[133528665] transaction","detail":"{read_only:false; response_revision:8964; number_of_response:1; }","duration":"157.645661ms","start":"2026-02-26T03:29:35.519753Z","end":"2026-02-26T03:29:35.677398Z","steps":["trace[133528665] 'process raft request' (duration: 157.594429ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:35.6776Z","caller":"traceutil/trace.go:171","msg":"trace[1394002878] transaction","detail":"{read_only:false; response_revision:8963; number_of_response:1; }","duration":"242.106321ms","start":"2026-02-26T03:29:35.435457Z","end":"2026-02-26T03:29:35.677564Z","steps":["trace[1394002878] 'process raft request' (duration: 241.813973ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:35.677598Z","caller":"traceutil/trace.go:171","msg":"trace[2137479412] transaction","detail":"{read_only:false; response_revision:8962; number_of_response:1; }","duration":"242.512012ms","start":"2026-02-26T03:29:35.435051Z","end":"2026-02-26T03:29:35.677563Z","steps":["trace[2137479412] 'process raft request' (duration: 236.335023ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:29:35.677859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.624288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/glance-ks-endpoints-gbwll\" ","response":"range_response_count:1 size:12947"} {"level":"info","ts":"2026-02-26T03:29:35.677898Z","caller":"traceutil/trace.go:171","msg":"trace[1520169783] linearizableReadLoop","detail":"{readStateIndex:9288; appliedIndex:9285; }","duration":"234.332371ms","start":"2026-02-26T03:29:35.443208Z","end":"2026-02-26T03:29:35.67754Z","steps":["trace[1520169783] 'read index received' (duration: 26.072103ms)","trace[1520169783] 'applied index is now lower than readState.Index' (duration: 208.215687ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:29:35.677975Z","caller":"traceutil/trace.go:171","msg":"trace[1139227575] range","detail":"{range_begin:/registry/pods/openstack/glance-ks-endpoints-gbwll; range_end:; response_count:1; response_revision:8964; }","duration":"234.768572ms","start":"2026-02-26T03:29:35.443171Z","end":"2026-02-26T03:29:35.677939Z","steps":["trace[1139227575] 'agreement among raft nodes before linearized reading' (duration: 234.464734ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:43.822004Z","caller":"traceutil/trace.go:171","msg":"trace[874241759] transaction","detail":"{read_only:false; response_revision:9021; number_of_response:1; }","duration":"114.988899ms","start":"2026-02-26T03:29:43.706985Z","end":"2026-02-26T03:29:43.821974Z","steps":["trace[874241759] 'process raft request' (duration: 114.393464ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:47.312111Z","caller":"traceutil/trace.go:171","msg":"trace[1314082671] linearizableReadLoop","detail":"{readStateIndex:9365; appliedIndex:9364; }","duration":"110.423691ms","start":"2026-02-26T03:29:47.201661Z","end":"2026-02-26T03:29:47.312085Z","steps":["trace[1314082671] 'read index received' (duration: 110.176415ms)","trace[1314082671] 'applied index is now lower than readState.Index' (duration: 246.126µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:29:47.31234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.651007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kwrnr\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-02-26T03:29:47.312341Z","caller":"traceutil/trace.go:171","msg":"trace[517915317] transaction","detail":"{read_only:false; response_revision:9038; number_of_response:1; }","duration":"115.168224ms","start":"2026-02-26T03:29:47.19714Z","end":"2026-02-26T03:29:47.312308Z","steps":["trace[517915317] 'process raft request' (duration: 114.748253ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:47.312395Z","caller":"traceutil/trace.go:171","msg":"trace[1800616818] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kwrnr; range_end:; response_count:1; response_revision:9038; }","duration":"110.719629ms","start":"2026-02-26T03:29:47.201657Z","end":"2026-02-26T03:29:47.312377Z","steps":["trace[1800616818] 'agreement among raft nodes before linearized reading' (duration: 110.530183ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:47.350572Z","caller":"traceutil/trace.go:171","msg":"trace[1190417644] transaction","detail":"{read_only:false; response_revision:9039; number_of_response:1; }","duration":"103.432181ms","start":"2026-02-26T03:29:47.247115Z","end":"2026-02-26T03:29:47.350547Z","steps":["trace[1190417644] 'process raft request' (duration: 84.4369ms)","trace[1190417644] 'compare' (duration: 18.032856ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:29:48.927316Z","caller":"traceutil/trace.go:171","msg":"trace[97954602] transaction","detail":"{read_only:false; response_revision:9047; number_of_response:1; }","duration":"151.964514ms","start":"2026-02-26T03:29:48.775322Z","end":"2026-02-26T03:29:48.927287Z","steps":["trace[97954602] 'process raft request' (duration: 151.762149ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:29:49.391808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.954676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-02-26T03:29:49.391918Z","caller":"traceutil/trace.go:171","msg":"trace[232818397] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9047; }","duration":"271.171612ms","start":"2026-02-26T03:29:49.120718Z","end":"2026-02-26T03:29:49.39189Z","steps":["trace[232818397] 'range keys from in-memory index tree' (duration: 270.702649ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:29:49.842902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.36091ms","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-02-26T03:29:49.843022Z","caller":"traceutil/trace.go:171","msg":"trace[2024984400] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:9049; }","duration":"184.564575ms","start":"2026-02-26T03:29:49.658434Z","end":"2026-02-26T03:29:49.842998Z","steps":["trace[2024984400] 'range keys from in-memory index tree' (duration: 184.231627ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:50.030581Z","caller":"traceutil/trace.go:171","msg":"trace[334511043] linearizableReadLoop","detail":"{readStateIndex:9378; appliedIndex:9377; }","duration":"167.104184ms","start":"2026-02-26T03:29:49.863439Z","end":"2026-02-26T03:29:50.030543Z","steps":["trace[334511043] 'read index received' (duration: 166.687624ms)","trace[334511043] 'applied index is now lower than readState.Index' (duration: 414.31µs)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:29:50.030778Z","caller":"traceutil/trace.go:171","msg":"trace[1796021915] transaction","detail":"{read_only:false; response_revision:9050; number_of_response:1; }","duration":"167.958137ms","start":"2026-02-26T03:29:49.862802Z","end":"2026-02-26T03:29:50.03076Z","steps":["trace[1796021915] 'process raft request' (duration: 167.491574ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:29:50.030971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.001018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-26T03:29:50.031061Z","caller":"traceutil/trace.go:171","msg":"trace[678653011] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9050; }","duration":"137.170671ms","start":"2026-02-26T03:29:49.893869Z","end":"2026-02-26T03:29:50.03104Z","steps":["trace[678653011] 'agreement among raft nodes before linearized reading' (duration: 136.934156ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:29:50.031232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.794372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-02-26T03:29:50.031255Z","caller":"traceutil/trace.go:171","msg":"trace[1597296942] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:9050; }","duration":"167.845393ms","start":"2026-02-26T03:29:49.863399Z","end":"2026-02-26T03:29:50.031244Z","steps":["trace[1597296942] 'agreement among raft nodes before linearized reading' (duration: 167.770682ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:29:50.810196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"736.839226ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-26T03:29:50.810452Z","caller":"traceutil/trace.go:171","msg":"trace[409475534] linearizableReadLoop","detail":"{readStateIndex:9379; appliedIndex:9378; }","duration":"758.976917ms","start":"2026-02-26T03:29:50.051443Z","end":"2026-02-26T03:29:50.81042Z","steps":["trace[409475534] 'read index received' (duration: 21.825383ms)","trace[409475534] 'applied index is now lower than readState.Index' (duration: 737.149724ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:29:50.810497Z","caller":"traceutil/trace.go:171","msg":"trace[794656479] transaction","detail":"{read_only:false; response_revision:9051; number_of_response:1; }","duration":"773.84573ms","start":"2026-02-26T03:29:50.036598Z","end":"2026-02-26T03:29:50.810444Z","steps":["trace[794656479] 'process raft request' (duration: 36.634355ms)","trace[794656479] 'compare' (duration: 736.548788ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:29:50.810745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:29:50.036561Z","time spent":"774.050925ms","remote":"127.0.0.1:53574","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-02-26T03:29:50.810958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.4703ms","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-02-26T03:29:50.811074Z","caller":"traceutil/trace.go:171","msg":"trace[388986888] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9051; }","duration":"759.659694ms","start":"2026-02-26T03:29:50.051387Z","end":"2026-02-26T03:29:50.811046Z","steps":["trace[388986888] 'agreement among raft nodes before linearized reading' (duration: 759.096049ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:29:50.811132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:29:50.05136Z","time spent":"759.759647ms","remote":"127.0.0.1:53574","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-02-26T03:29:50.992797Z","caller":"traceutil/trace.go:171","msg":"trace[1544265041] transaction","detail":"{read_only:false; response_revision:9052; number_of_response:1; }","duration":"573.162149ms","start":"2026-02-26T03:29:50.419606Z","end":"2026-02-26T03:29:50.992768Z","steps":["trace[1544265041] 'process raft request' (duration: 572.637836ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:29:50.993003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:29:50.419574Z","time spent":"573.301553ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T03:29:50.993633Z","caller":"traceutil/trace.go:171","msg":"trace[1548472996] linearizableReadLoop","detail":"{readStateIndex:9380; appliedIndex:9380; }","duration":"183.067727ms","start":"2026-02-26T03:29:50.810516Z","end":"2026-02-26T03:29:50.993583Z","steps":["trace[1548472996] 'read index received' (duration: 183.031146ms)","trace[1548472996] 'applied index is now lower than readState.Index' (duration: 32.921µs)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:29:50.994072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"909.417881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-26T03:29:50.994191Z","caller":"traceutil/trace.go:171","msg":"trace[275533533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9052; }","duration":"909.610077ms","start":"2026-02-26T03:29:50.084565Z","end":"2026-02-26T03:29:50.994175Z","steps":["trace[275533533] 'agreement among raft nodes before linearized reading' (duration: 909.210686ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:29:50.99429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:29:50.084489Z","time spent":"909.785811ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T03:29:50.995468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.574546ms","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-02-26T03:29:50.995522Z","caller":"traceutil/trace.go:171","msg":"trace[2051683682] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9052; }","duration":"890.675708ms","start":"2026-02-26T03:29:50.104834Z","end":"2026-02-26T03:29:50.995509Z","steps":["trace[2051683682] 'agreement among raft nodes before linearized reading' (duration: 888.799159ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:29:50.995547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:29:50.104807Z","time spent":"890.734249ms","remote":"127.0.0.1:53574","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-02-26T03:29:50.997945Z","caller":"traceutil/trace.go:171","msg":"trace[1672920140] transaction","detail":"{read_only:false; response_revision:9053; number_of_response:1; }","duration":"182.700167ms","start":"2026-02-26T03:29:50.815216Z","end":"2026-02-26T03:29:50.997916Z","steps":["trace[1672920140] 'process raft request' (duration: 182.474972ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:51.181509Z","caller":"traceutil/trace.go:171","msg":"trace[1933068983] transaction","detail":"{read_only:false; response_revision:9055; number_of_response:1; }","duration":"181.788493ms","start":"2026-02-26T03:29:50.999676Z","end":"2026-02-26T03:29:51.181464Z","steps":["trace[1933068983] 'process raft request' (duration: 168.306455ms)","trace[1933068983] 'compare' (duration: 13.294883ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:29:51.185729Z","caller":"traceutil/trace.go:171","msg":"trace[2017374021] linearizableReadLoop","detail":"{readStateIndex:9384; appliedIndex:9382; }","duration":"170.244596ms","start":"2026-02-26T03:29:51.01547Z","end":"2026-02-26T03:29:51.185714Z","steps":["trace[2017374021] 'read index received' (duration: 152.555759ms)","trace[2017374021] 'applied index is now lower than readState.Index' (duration: 17.687327ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:29:51.185862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.368858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:29:51.185904Z","caller":"traceutil/trace.go:171","msg":"trace[1411231695] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:9056; }","duration":"170.481522ms","start":"2026-02-26T03:29:51.015409Z","end":"2026-02-26T03:29:51.185891Z","steps":["trace[1411231695] 'agreement among raft nodes before linearized reading' (duration: 170.357338ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:51.185959Z","caller":"traceutil/trace.go:171","msg":"trace[708668705] transaction","detail":"{read_only:false; response_revision:9056; number_of_response:1; }","duration":"186.004802ms","start":"2026-02-26T03:29:50.999904Z","end":"2026-02-26T03:29:51.185909Z","steps":["trace[708668705] 'process raft request' (duration: 185.708154ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:52.69765Z","caller":"traceutil/trace.go:171","msg":"trace[1838516447] transaction","detail":"{read_only:false; response_revision:9061; number_of_response:1; }","duration":"204.432878ms","start":"2026-02-26T03:29:52.49318Z","end":"2026-02-26T03:29:52.697613Z","steps":["trace[1838516447] 'process raft request' (duration: 204.214013ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:53.838338Z","caller":"traceutil/trace.go:171","msg":"trace[1554222432] transaction","detail":"{read_only:false; response_revision:9071; number_of_response:1; }","duration":"127.672516ms","start":"2026-02-26T03:29:53.710645Z","end":"2026-02-26T03:29:53.838318Z","steps":["trace[1554222432] 'process raft request' (duration: 127.270306ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:54.170332Z","caller":"traceutil/trace.go:171","msg":"trace[1172126871] transaction","detail":"{read_only:false; response_revision:9075; number_of_response:1; }","duration":"148.404662ms","start":"2026-02-26T03:29:54.021872Z","end":"2026-02-26T03:29:54.170277Z","steps":["trace[1172126871] 'process raft request' (duration: 146.925064ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:54.173632Z","caller":"traceutil/trace.go:171","msg":"trace[644493714] transaction","detail":"{read_only:false; response_revision:9076; number_of_response:1; }","duration":"111.229172ms","start":"2026-02-26T03:29:54.062388Z","end":"2026-02-26T03:29:54.173617Z","steps":["trace[644493714] 'process raft request' (duration: 111.063218ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:54.369528Z","caller":"traceutil/trace.go:171","msg":"trace[1194716847] transaction","detail":"{read_only:false; response_revision:9079; number_of_response:1; }","duration":"101.319596ms","start":"2026-02-26T03:29:54.268175Z","end":"2026-02-26T03:29:54.369494Z","steps":["trace[1194716847] 'process raft request' (duration: 97.741694ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:54.521394Z","caller":"traceutil/trace.go:171","msg":"trace[1536092505] transaction","detail":"{read_only:false; response_revision:9082; number_of_response:1; }","duration":"142.062618ms","start":"2026-02-26T03:29:54.379302Z","end":"2026-02-26T03:29:54.521365Z","steps":["trace[1536092505] 'process raft request' (duration: 141.976606ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:54.52141Z","caller":"traceutil/trace.go:171","msg":"trace[1324777178] transaction","detail":"{read_only:false; response_revision:9081; number_of_response:1; }","duration":"145.027864ms","start":"2026-02-26T03:29:54.376348Z","end":"2026-02-26T03:29:54.521376Z","steps":["trace[1324777178] 'process raft request' (duration: 138.481285ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:55.366719Z","caller":"traceutil/trace.go:171","msg":"trace[817772312] transaction","detail":"{read_only:false; response_revision:9090; number_of_response:1; }","duration":"134.192084ms","start":"2026-02-26T03:29:55.232487Z","end":"2026-02-26T03:29:55.366679Z","steps":["trace[817772312] 'process raft request' (duration: 133.897047ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:55.369087Z","caller":"traceutil/trace.go:171","msg":"trace[740807] linearizableReadLoop","detail":"{readStateIndex:9420; appliedIndex:9418; }","duration":"124.352861ms","start":"2026-02-26T03:29:55.244707Z","end":"2026-02-26T03:29:55.369059Z","steps":["trace[740807] 'read index received' (duration: 121.798765ms)","trace[740807] 'applied index is now lower than readState.Index' (duration: 2.553116ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:29:55.36932Z","caller":"traceutil/trace.go:171","msg":"trace[2087003685] transaction","detail":"{read_only:false; response_revision:9091; number_of_response:1; }","duration":"135.058368ms","start":"2026-02-26T03:29:55.234056Z","end":"2026-02-26T03:29:55.369114Z","steps":["trace[2087003685] 'process raft request' (duration: 134.875443ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:29:55.369435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.694369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-02-26T03:29:55.369511Z","caller":"traceutil/trace.go:171","msg":"trace[1166336887] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9091; }","duration":"124.834723ms","start":"2026-02-26T03:29:55.244659Z","end":"2026-02-26T03:29:55.369493Z","steps":["trace[1166336887] 'agreement among raft nodes before linearized reading' (duration: 124.574917ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:55.611097Z","caller":"traceutil/trace.go:171","msg":"trace[979962274] linearizableReadLoop","detail":"{readStateIndex:9421; appliedIndex:9420; }","duration":"150.273669ms","start":"2026-02-26T03:29:55.460788Z","end":"2026-02-26T03:29:55.611062Z","steps":["trace[979962274] 'read index received' (duration: 55.085442ms)","trace[979962274] 'applied index is now lower than readState.Index' (duration: 95.186777ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:29:55.611638Z","caller":"traceutil/trace.go:171","msg":"trace[1899927834] transaction","detail":"{read_only:false; response_revision:9092; number_of_response:1; }","duration":"164.425765ms","start":"2026-02-26T03:29:55.447173Z","end":"2026-02-26T03:29:55.611599Z","steps":["trace[1899927834] 'process raft request' (duration: 68.706134ms)","trace[1899927834] 'compare' (duration: 94.987892ms)"],"step_count":2} {"level":"warn","ts":"2026-02-26T03:29:55.611741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.914605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kwrnr\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-02-26T03:29:55.611891Z","caller":"traceutil/trace.go:171","msg":"trace[1304206473] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kwrnr; range_end:; response_count:1; response_revision:9092; }","duration":"151.106421ms","start":"2026-02-26T03:29:55.460712Z","end":"2026-02-26T03:29:55.611819Z","steps":["trace[1304206473] 'agreement among raft nodes before linearized reading' (duration: 150.707121ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:29:55.765839Z","caller":"traceutil/trace.go:171","msg":"trace[1230382765] transaction","detail":"{read_only:false; response_revision:9094; number_of_response:1; }","duration":"144.578663ms","start":"2026-02-26T03:29:55.621228Z","end":"2026-02-26T03:29:55.765806Z","steps":["trace[1230382765] 'process raft request' (duration: 137.827599ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:30:56.174073Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4092255387779570844,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-26T03:30:56.545621Z","caller":"traceutil/trace.go:171","msg":"trace[1024797500] transaction","detail":"{read_only:false; response_revision:9453; number_of_response:1; }","duration":"872.010285ms","start":"2026-02-26T03:30:55.673586Z","end":"2026-02-26T03:30:56.545596Z","steps":["trace[1024797500] 'process raft request' (duration: 871.851742ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:30:56.545773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:30:55.673566Z","time spent":"872.133889ms","remote":"127.0.0.1:58798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2447,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-26T03:30:56.547037Z","caller":"traceutil/trace.go:171","msg":"trace[1134901673] linearizableReadLoop","detail":"{readStateIndex:9799; appliedIndex:9795; }","duration":"873.238856ms","start":"2026-02-26T03:30:55.673777Z","end":"2026-02-26T03:30:56.547016Z","steps":["trace[1134901673] 'read index received' (duration: 871.686896ms)","trace[1134901673] 'applied index is now lower than readState.Index' (duration: 1.5506ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:30:56.547636Z","caller":"traceutil/trace.go:171","msg":"trace[73607916] transaction","detail":"{read_only:false; response_revision:9454; number_of_response:1; }","duration":"867.812157ms","start":"2026-02-26T03:30:55.679565Z","end":"2026-02-26T03:30:56.547378Z","steps":["trace[73607916] 'process raft request' (duration: 867.203881ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:30:56.547855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:30:55.679537Z","time spent":"868.174556ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T03:30:56.548082Z","caller":"traceutil/trace.go:171","msg":"trace[2002568599] transaction","detail":"{read_only:false; response_revision:9455; number_of_response:1; }","duration":"863.826553ms","start":"2026-02-26T03:30:55.684222Z","end":"2026-02-26T03:30:56.548049Z","steps":["trace[2002568599] 'process raft request' (duration: 862.657034ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:30:56.548176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:30:55.684202Z","time spent":"863.926766ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-26T03:30:56.548208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"873.164096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T03:30:56.548276Z","caller":"traceutil/trace.go:171","msg":"trace[1429573753] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:9457; }","duration":"873.292779ms","start":"2026-02-26T03:30:55.674967Z","end":"2026-02-26T03:30:56.54826Z","steps":["trace[1429573753] 'agreement among raft nodes before linearized reading' (duration: 873.145315ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:30:56.548337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:30:55.674954Z","time spent":"873.350341ms","remote":"127.0.0.1:43608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-02-26T03:30:56.548528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.960646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-26T03:30:56.548554Z","caller":"traceutil/trace.go:171","msg":"trace[1133469131] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:9457; }","duration":"838.016598ms","start":"2026-02-26T03:30:55.710531Z","end":"2026-02-26T03:30:56.548547Z","steps":["trace[1133469131] 'agreement among raft nodes before linearized reading' (duration: 837.969856ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:30:56.548528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.675062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-26T03:30:56.54861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.074149ms","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-02-26T03:30:56.548636Z","caller":"traceutil/trace.go:171","msg":"trace[1633552624] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9457; }","duration":"743.793245ms","start":"2026-02-26T03:30:55.804805Z","end":"2026-02-26T03:30:56.548598Z","steps":["trace[1633552624] 'agreement among raft nodes before linearized reading' (duration: 743.676162ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:30:56.548652Z","caller":"traceutil/trace.go:171","msg":"trace[785821172] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9457; }","duration":"869.150671ms","start":"2026-02-26T03:30:55.679492Z","end":"2026-02-26T03:30:56.548643Z","steps":["trace[785821172] 'agreement among raft nodes before linearized reading' (duration: 869.020348ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:30:56.548671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:30:55.804791Z","time spent":"743.873536ms","remote":"127.0.0.1:58690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-26T03:30:56.548683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:30:55.67947Z","time spent":"869.205613ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-26T03:30:56.548733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.235413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-02-26T03:30:56.548757Z","caller":"traceutil/trace.go:171","msg":"trace[1645547362] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9457; }","duration":"869.280575ms","start":"2026-02-26T03:30:55.67947Z","end":"2026-02-26T03:30:56.548751Z","steps":["trace[1645547362] 'agreement among raft nodes before linearized reading' (duration: 869.217893ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:30:56.548777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:30:55.679454Z","time spent":"869.319226ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-26T03:30:56.548807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.281302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-26T03:30:56.548847Z","caller":"traceutil/trace.go:171","msg":"trace[1265638053] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:9457; }","duration":"865.334993ms","start":"2026-02-26T03:30:55.683501Z","end":"2026-02-26T03:30:56.548836Z","steps":["trace[1265638053] 'agreement among raft nodes before linearized reading' (duration: 865.25651ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:30:56.54888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:30:55.683493Z","time spent":"865.377164ms","remote":"127.0.0.1:55364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":22,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true "} {"level":"info","ts":"2026-02-26T03:30:56.548896Z","caller":"traceutil/trace.go:171","msg":"trace[564072599] transaction","detail":"{read_only:false; response_revision:9456; number_of_response:1; }","duration":"802.700176ms","start":"2026-02-26T03:30:55.746185Z","end":"2026-02-26T03:30:56.548885Z","steps":["trace[564072599] 'process raft request' (duration: 800.741375ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:30:56.548977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"867.344035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"warn","ts":"2026-02-26T03:30:56.548993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:30:55.746165Z","time spent":"802.751968ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-26T03:30:56.549005Z","caller":"traceutil/trace.go:171","msg":"trace[85346780] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:9457; }","duration":"867.384106ms","start":"2026-02-26T03:30:55.681613Z","end":"2026-02-26T03:30:56.548997Z","steps":["trace[85346780] 'agreement among raft nodes before linearized reading' (duration: 867.312554ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:30:56.549026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:30:55.681603Z","time spent":"867.418357ms","remote":"127.0.0.1:58860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" "} {"level":"warn","ts":"2026-02-26T03:30:56.549156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.839395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-kwrnr\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-02-26T03:30:56.549195Z","caller":"traceutil/trace.go:171","msg":"trace[78330097] range","detail":"{range_begin:/registry/pods/openstack/keepalived-kwrnr; range_end:; response_count:1; response_revision:9457; }","duration":"425.906036ms","start":"2026-02-26T03:30:56.123277Z","end":"2026-02-26T03:30:56.549183Z","steps":["trace[78330097] 'agreement among raft nodes before linearized reading' (duration: 425.807314ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:30:56.549226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:30:56.123263Z","time spent":"425.955688ms","remote":"127.0.0.1:58894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6543,"request content":"key:\"/registry/pods/openstack/keepalived-kwrnr\" "} {"level":"warn","ts":"2026-02-26T03:30:56.549216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.547945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-02-26T03:30:56.549256Z","caller":"traceutil/trace.go:171","msg":"trace[1155474610] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9457; }","duration":"567.587666ms","start":"2026-02-26T03:30:55.981662Z","end":"2026-02-26T03:30:56.549249Z","steps":["trace[1155474610] 'agreement among raft nodes before linearized reading' (duration: 567.437542ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:30:56.549305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:30:55.981609Z","time spent":"567.689968ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-26T03:30:56.548578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:30:55.710515Z","time spent":"838.052959ms","remote":"127.0.0.1:33482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-02-26T03:30:56.548669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.143581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-02-26T03:30:56.549532Z","caller":"traceutil/trace.go:171","msg":"trace[1836803601] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9457; }","duration":"870.012044ms","start":"2026-02-26T03:30:55.67949Z","end":"2026-02-26T03:30:56.549502Z","steps":["trace[1836803601] 'agreement among raft nodes before linearized reading' (duration: 869.10444ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:30:56.549561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:30:55.679465Z","time spent":"870.088026ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-26T03:30:56.550447Z","caller":"traceutil/trace.go:171","msg":"trace[737911828] transaction","detail":"{read_only:false; response_revision:9457; number_of_response:1; }","duration":"121.59686ms","start":"2026-02-26T03:30:56.428842Z","end":"2026-02-26T03:30:56.550439Z","steps":["trace[737911828] 'process raft request' (duration: 118.12893ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:30:56.552804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"878.996444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-02-26T03:30:56.552879Z","caller":"traceutil/trace.go:171","msg":"trace[1647134803] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9457; }","duration":"879.099958ms","start":"2026-02-26T03:30:55.673764Z","end":"2026-02-26T03:30:56.552864Z","steps":["trace[1647134803] 'agreement among raft nodes before linearized reading' (duration: 875.427733ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:30:56.552908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-26T03:30:55.673758Z","time spent":"879.142289ms","remote":"127.0.0.1:53574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-26T03:31:24.819233Z","caller":"traceutil/trace.go:171","msg":"trace[206313109] transaction","detail":"{read_only:false; response_revision:9606; number_of_response:1; }","duration":"170.713327ms","start":"2026-02-26T03:31:24.648497Z","end":"2026-02-26T03:31:24.819211Z","steps":["trace[206313109] 'process raft request' (duration: 170.514843ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:31:24.819437Z","caller":"traceutil/trace.go:171","msg":"trace[12359277] linearizableReadLoop","detail":"{readStateIndex:9958; appliedIndex:9956; }","duration":"134.765831ms","start":"2026-02-26T03:31:24.684644Z","end":"2026-02-26T03:31:24.81941Z","steps":["trace[12359277] 'read index received' (duration: 6.633182ms)","trace[12359277] 'applied index is now lower than readState.Index' (duration: 128.131059ms)"],"step_count":2} {"level":"info","ts":"2026-02-26T03:31:24.819447Z","caller":"traceutil/trace.go:171","msg":"trace[308840954] transaction","detail":"{read_only:false; response_revision:9607; number_of_response:1; }","duration":"170.870743ms","start":"2026-02-26T03:31:24.648553Z","end":"2026-02-26T03:31:24.819424Z","steps":["trace[308840954] 'process raft request' (duration: 170.618125ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:31:24.819624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.962456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-02-26T03:31:24.819701Z","caller":"traceutil/trace.go:171","msg":"trace[1712282937] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9607; }","duration":"135.083169ms","start":"2026-02-26T03:31:24.684602Z","end":"2026-02-26T03:31:24.819685Z","steps":["trace[1712282937] 'agreement among raft nodes before linearized reading' (duration: 134.893924ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:31:24.819746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.04444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-02-26T03:31:24.819768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.841286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-02-26T03:31:24.819799Z","caller":"traceutil/trace.go:171","msg":"trace[1278942769] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9607; }","duration":"127.106931ms","start":"2026-02-26T03:31:24.692679Z","end":"2026-02-26T03:31:24.819786Z","steps":["trace[1278942769] 'agreement among raft nodes before linearized reading' (duration: 126.946678ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:31:24.819814Z","caller":"traceutil/trace.go:171","msg":"trace[1694795837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9607; }","duration":"126.917827ms","start":"2026-02-26T03:31:24.692882Z","end":"2026-02-26T03:31:24.8198Z","steps":["trace[1694795837] 'agreement among raft nodes before linearized reading' (duration: 126.784664ms)"],"step_count":1} {"level":"warn","ts":"2026-02-26T03:31:24.819803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.829425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-02-26T03:31:24.819871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.167703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-02-26T03:31:24.819905Z","caller":"traceutil/trace.go:171","msg":"trace[118117273] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9607; }","duration":"127.224345ms","start":"2026-02-26T03:31:24.69267Z","end":"2026-02-26T03:31:24.819894Z","steps":["trace[118117273] 'agreement among raft nodes before linearized reading' (duration: 127.140523ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:31:24.819893Z","caller":"traceutil/trace.go:171","msg":"trace[1886849818] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9607; }","duration":"126.973929ms","start":"2026-02-26T03:31:24.692901Z","end":"2026-02-26T03:31:24.819875Z","steps":["trace[1886849818] 'agreement among raft nodes before linearized reading' (duration: 126.721533ms)"],"step_count":1} {"level":"info","ts":"2026-02-26T03:31:33.095828Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b4c6dc24a78438ca","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-02-26T03:31:33.101433Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-02-26T03:31:33.101502Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-02-26T03:32:14.548526Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7782} {"level":"info","ts":"2026-02-26T03:32:14.615993Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7782,"took":"65.303736ms","hash":778975769,"current-db-size-bytes":42668032,"current-db-size":"43 MB","current-db-size-in-use-bytes":25272320,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-02-26T03:32:14.61607Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":778975769,"revision":7782,"compact-revision":5765}