{"level":"warn","ts":"2026-10-26T19:18:16.10672Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-26T19:18:16.106829Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.203: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.203:2380","--initial-cluster=instance=https://162.253.55.203:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.203:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.203: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-10-26T19:18:16.106916Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-26T19:18:16.106934Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.203:2380"]}
{"level":"info","ts":"2026-10-26T19:18:16.106964Z","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-10-26T19:18:16.107714Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.203:2379"]}
{"level":"info","ts":"2026-10-26T19:18:16.107795Z","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.203:2380"],"listen-peer-urls":["https://162.253.55.203:2380"],"advertise-client-urls":["https://162.253.55.203:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.203:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.203: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-10-26T19:18:16.15441Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"44.661368ms"}
{"level":"info","ts":"2026-10-26T19:18:16.175329Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a656331365382b34","cluster-id":"84e77d9b2eaf556a"}
{"level":"info","ts":"2026-10-26T19:18:16.175474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 switched to configuration voters=()"}
{"level":"info","ts":"2026-10-26T19:18:16.175496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 became follower at term 0"}
{"level":"info","ts":"2026-10-26T19:18:16.175508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a656331365382b34 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-26T19:18:16.175516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 became follower at term 1"}
{"level":"info","ts":"2026-10-26T19:18:16.175559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 switched to configuration voters=(11985823616688728884)"}
{"level":"warn","ts":"2026-10-26T19:18:16.196011Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-26T19:18:16.199401Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-26T19:18:16.201864Z","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-10-26T19:18:16.206526Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a656331365382b34","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-26T19:18:16.208864Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a656331365382b34","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-26T19:18:16.20911Z","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-10-26T19:18:16.20918Z","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-10-26T19:18:16.209196Z","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-10-26T19:18:16.2096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 switched to configuration voters=(11985823616688728884)"}
{"level":"info","ts":"2026-10-26T19:18:16.209952Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"84e77d9b2eaf556a","local-member-id":"a656331365382b34","added-peer-id":"a656331365382b34","added-peer-peer-urls":["https://162.253.55.203:2380"]}
{"level":"info","ts":"2026-10-26T19:18:16.210965Z","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-10-26T19:18:16.211073Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.203:2380"}
{"level":"info","ts":"2026-10-26T19:18:16.211129Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.203:2380"}
{"level":"info","ts":"2026-10-26T19:18:16.211212Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a656331365382b34","initial-advertise-peer-urls":["https://162.253.55.203:2380"],"listen-peer-urls":["https://162.253.55.203:2380"],"advertise-client-urls":["https://162.253.55.203:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.203:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-26T19:18:16.211251Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-26T19:18:16.576018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 is starting a new election at term 1"}
{"level":"info","ts":"2026-10-26T19:18:16.57607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-26T19:18:16.576105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 received MsgPreVoteResp from a656331365382b34 at term 1"}
{"level":"info","ts":"2026-10-26T19:18:16.576118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 became candidate at term 2"}
{"level":"info","ts":"2026-10-26T19:18:16.576125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 received MsgVoteResp from a656331365382b34 at term 2"}
{"level":"info","ts":"2026-10-26T19:18:16.57614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 became leader at term 2"}
{"level":"info","ts":"2026-10-26T19:18:16.576149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a656331365382b34 elected leader a656331365382b34 at term 2"}
{"level":"info","ts":"2026-10-26T19:18:16.577443Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a656331365382b34","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.203:2379]}","request-path":"/0/members/a656331365382b34/attributes","cluster-id":"84e77d9b2eaf556a","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-26T19:18:16.577472Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-26T19:18:16.577595Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-26T19:18:16.577664Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-26T19:18:16.577844Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-26T19:18:16.577948Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-26T19:18:16.579Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"84e77d9b2eaf556a","local-member-id":"a656331365382b34","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-26T19:18:16.579125Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-26T19:18:16.579156Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-26T19:18:16.58007Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.203:2379"}
{"level":"info","ts":"2026-10-26T19:18:16.580276Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-26T19:18:36.387864Z","caller":"traceutil/trace.go:171","msg":"trace[1337861418] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"154.363904ms","start":"2026-10-26T19:18:36.233409Z","end":"2026-10-26T19:18:36.387773Z","steps":["trace[1337861418] 'process raft request'  (duration: 144.724319ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:19:01.967655Z","caller":"traceutil/trace.go:171","msg":"trace[71067184] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"102.536599ms","start":"2026-10-26T19:19:01.865094Z","end":"2026-10-26T19:19:01.96763Z","steps":["trace[71067184] 'process raft request'  (duration: 53.756468ms)","trace[71067184] 'compare'  (duration: 48.668668ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:19:04.866975Z","caller":"traceutil/trace.go:171","msg":"trace[1918195786] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"152.392089ms","start":"2026-10-26T19:19:04.714561Z","end":"2026-10-26T19:19:04.866953Z","steps":["trace[1918195786] 'process raft request'  (duration: 152.06513ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:19:11.206481Z","caller":"traceutil/trace.go:171","msg":"trace[698871278] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"165.299625ms","start":"2026-10-26T19:19:11.041154Z","end":"2026-10-26T19:19:11.206453Z","steps":["trace[698871278] 'process raft request'  (duration: 164.658937ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:19:11.578633Z","caller":"traceutil/trace.go:171","msg":"trace[1778789412] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"348.951434ms","start":"2026-10-26T19:19:11.229652Z","end":"2026-10-26T19:19:11.578603Z","steps":["trace[1778789412] 'process raft request'  (duration: 348.755108ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:19:11.579227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:19:11.229619Z","time spent":"349.102758ms","remote":"127.0.0.1:52158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-n65sc\" mod_revision:499 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-n65sc\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-n65sc\" > >"}
{"level":"info","ts":"2026-10-26T19:19:11.602223Z","caller":"traceutil/trace.go:171","msg":"trace[73969808] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:648; }","duration":"285.822168ms","start":"2026-10-26T19:19:11.316368Z","end":"2026-10-26T19:19:11.60219Z","steps":["trace[73969808] 'read index received'  (duration: 262.066295ms)","trace[73969808] 'applied index is now lower than readState.Index'  (duration: 23.754953ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:19:11.60231Z","caller":"traceutil/trace.go:171","msg":"trace[1781060938] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"322.918398ms","start":"2026-10-26T19:19:11.279357Z","end":"2026-10-26T19:19:11.602275Z","steps":["trace[1781060938] 'process raft request'  (duration: 322.709713ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:19:11.602475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:19:11.279337Z","time spent":"323.067282ms","remote":"127.0.0.1:52220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:2525 >> failure:<>"}
{"level":"warn","ts":"2026-10-26T19:19:11.602462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.079685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:19:11.602619Z","caller":"traceutil/trace.go:171","msg":"trace[770988387] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:624; }","duration":"286.298222ms","start":"2026-10-26T19:19:11.316307Z","end":"2026-10-26T19:19:11.602605Z","steps":["trace[770988387] 'agreement among raft nodes before linearized reading'  (duration: 286.021104ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:19:11.602658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.651617ms","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-10-26T19:19:11.60276Z","caller":"traceutil/trace.go:171","msg":"trace[336744422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:624; }","duration":"148.77325ms","start":"2026-10-26T19:19:11.453961Z","end":"2026-10-26T19:19:11.602734Z","steps":["trace[336744422] 'agreement among raft nodes before linearized reading'  (duration: 148.456971ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:19:12.152931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.216465ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3113290786270966857 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:610 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-26T19:19:12.153195Z","caller":"traceutil/trace.go:171","msg":"trace[1102435996] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"543.301897ms","start":"2026-10-26T19:19:11.609877Z","end":"2026-10-26T19:19:12.153179Z","steps":["trace[1102435996] 'read index received'  (duration: 75.468145ms)","trace[1102435996] 'applied index is now lower than readState.Index'  (duration: 467.832452ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:19:12.153268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.382909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"}
{"level":"info","ts":"2026-10-26T19:19:12.153292Z","caller":"traceutil/trace.go:171","msg":"trace[1288277690] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:625; }","duration":"543.43188ms","start":"2026-10-26T19:19:11.609851Z","end":"2026-10-26T19:19:12.153283Z","steps":["trace[1288277690] 'agreement among raft nodes before linearized reading'  (duration: 543.369789ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:19:12.153329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:19:11.609841Z","time spent":"543.480752ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "}
{"level":"info","ts":"2026-10-26T19:19:12.153319Z","caller":"traceutil/trace.go:171","msg":"trace[1661984951] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"545.258411ms","start":"2026-10-26T19:19:11.608014Z","end":"2026-10-26T19:19:12.153273Z","steps":["trace[1661984951] 'process raft request'  (duration: 77.433719ms)","trace[1661984951] 'compare'  (duration: 467.02447ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:19:12.153494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:19:11.607993Z","time spent":"545.425925ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:610 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-10-26T19:19:17.508989Z","caller":"traceutil/trace.go:171","msg":"trace[1693227598] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"206.56487ms","start":"2026-10-26T19:19:17.302405Z","end":"2026-10-26T19:19:17.50897Z","steps":["trace[1693227598] 'process raft request'  (duration: 205.973294ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:19:17.707153Z","caller":"traceutil/trace.go:171","msg":"trace[1467197025] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"111.695435ms","start":"2026-10-26T19:19:17.595414Z","end":"2026-10-26T19:19:17.70711Z","steps":["trace[1467197025] 'process raft request'  (duration: 69.432161ms)","trace[1467197025] 'compare'  (duration: 41.870863ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:19:29.263663Z","caller":"traceutil/trace.go:171","msg":"trace[1013718146] linearizableReadLoop","detail":"{readStateIndex:822; appliedIndex:821; }","duration":"129.333538ms","start":"2026-10-26T19:19:29.1343Z","end":"2026-10-26T19:19:29.263633Z","steps":["trace[1013718146] 'read index received'  (duration: 129.114682ms)","trace[1013718146] 'applied index is now lower than readState.Index'  (duration: 217.386µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:19:29.263766Z","caller":"traceutil/trace.go:171","msg":"trace[206242575] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"157.588026ms","start":"2026-10-26T19:19:29.106098Z","end":"2026-10-26T19:19:29.263686Z","steps":["trace[206242575] 'process raft request'  (duration: 157.334829ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:19:29.263895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.552524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-26T19:19:29.263944Z","caller":"traceutil/trace.go:171","msg":"trace[1035773105] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:791; }","duration":"129.682227ms","start":"2026-10-26T19:19:29.134249Z","end":"2026-10-26T19:19:29.263931Z","steps":["trace[1035773105] 'agreement among raft nodes before linearized reading'  (duration: 129.557064ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:19:58.379728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.326054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:19:58.379827Z","caller":"traceutil/trace.go:171","msg":"trace[1422827185] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1185; }","duration":"187.483458ms","start":"2026-10-26T19:19:58.192327Z","end":"2026-10-26T19:19:58.37981Z","steps":["trace[1422827185] 'count revisions from in-memory index tree'  (duration: 187.215761ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:19:58.380113Z","caller":"traceutil/trace.go:171","msg":"trace[1418944050] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"175.725623ms","start":"2026-10-26T19:19:58.204352Z","end":"2026-10-26T19:19:58.380077Z","steps":["trace[1418944050] 'process raft request'  (duration: 158.698296ms)","trace[1418944050] 'compare'  (duration: 16.805321ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:20:48.9991Z","caller":"traceutil/trace.go:171","msg":"trace[887235476] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"398.533487ms","start":"2026-10-26T19:20:48.600505Z","end":"2026-10-26T19:20:48.999038Z","steps":["trace[887235476] 'process raft request'  (duration: 398.324551ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:20:48.999272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:20:48.600478Z","time spent":"398.714612ms","remote":"127.0.0.1:52158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0b361bc3-9344-4bc6-85e2-da0e9629dd5e\" mod_revision:1813 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0b361bc3-9344-4bc6-85e2-da0e9629dd5e\" value_size:3629 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0b361bc3-9344-4bc6-85e2-da0e9629dd5e\" > >"}
{"level":"info","ts":"2026-10-26T19:20:49.01697Z","caller":"traceutil/trace.go:171","msg":"trace[123942349] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"404.524058ms","start":"2026-10-26T19:20:48.612426Z","end":"2026-10-26T19:20:49.01695Z","steps":["trace[123942349] 'process raft request'  (duration: 396.260457ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:20:49.017126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:20:48.612404Z","time spent":"404.630921ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1844 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-10-26T19:20:49.017144Z","caller":"traceutil/trace.go:171","msg":"trace[1158350290] linearizableReadLoop","detail":"{readStateIndex:1940; appliedIndex:1938; }","duration":"292.124574ms","start":"2026-10-26T19:20:48.724996Z","end":"2026-10-26T19:20:49.01712Z","steps":["trace[1158350290] 'read index received'  (duration: 274.131361ms)","trace[1158350290] 'applied index is now lower than readState.Index'  (duration: 17.991233ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:20:49.017185Z","caller":"traceutil/trace.go:171","msg":"trace[1060452125] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"330.975606ms","start":"2026-10-26T19:20:48.686173Z","end":"2026-10-26T19:20:49.017148Z","steps":["trace[1060452125] 'process raft request'  (duration: 330.74368ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:20:49.017289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.303348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-10-26T19:20:49.017311Z","caller":"traceutil/trace.go:171","msg":"trace[110530522] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1866; }","duration":"292.37292ms","start":"2026-10-26T19:20:48.72493Z","end":"2026-10-26T19:20:49.017303Z","steps":["trace[110530522] 'agreement among raft nodes before linearized reading'  (duration: 292.286718ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:20:49.017313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:20:48.686134Z","time spent":"331.109399ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:1756 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-10-26T19:20:49.017864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.157664ms","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-10-26T19:20:49.017906Z","caller":"traceutil/trace.go:171","msg":"trace[524300221] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1866; }","duration":"220.238356ms","start":"2026-10-26T19:20:48.797657Z","end":"2026-10-26T19:20:49.017895Z","steps":["trace[524300221] 'agreement among raft nodes before linearized reading'  (duration: 219.581438ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:20:54.041374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.648529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-26T19:20:54.041469Z","caller":"traceutil/trace.go:171","msg":"trace[312326530] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1918; }","duration":"122.816863ms","start":"2026-10-26T19:20:53.918628Z","end":"2026-10-26T19:20:54.041445Z","steps":["trace[312326530] 'count revisions from in-memory index tree'  (duration: 122.511145ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:21:01.371653Z","caller":"traceutil/trace.go:171","msg":"trace[293729914] transaction","detail":"{read_only:false; response_revision:1976; number_of_response:1; }","duration":"112.63553ms","start":"2026-10-26T19:21:01.258974Z","end":"2026-10-26T19:21:01.371609Z","steps":["trace[293729914] 'process raft request'  (duration: 45.592372ms)","trace[293729914] 'compare'  (duration: 66.822792ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:21:04.162773Z","caller":"traceutil/trace.go:171","msg":"trace[1144980335] transaction","detail":"{read_only:false; response_revision:1995; number_of_response:1; }","duration":"115.366633ms","start":"2026-10-26T19:21:04.047383Z","end":"2026-10-26T19:21:04.16275Z","steps":["trace[1144980335] 'process raft request'  (duration: 115.204639ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:21:04.634313Z","caller":"traceutil/trace.go:171","msg":"trace[70137405] transaction","detail":"{read_only:false; response_revision:1997; number_of_response:1; }","duration":"160.444082ms","start":"2026-10-26T19:21:04.473852Z","end":"2026-10-26T19:21:04.634296Z","steps":["trace[70137405] 'process raft request'  (duration: 160.329769ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:21:04.674095Z","caller":"traceutil/trace.go:171","msg":"trace[122900214] linearizableReadLoop","detail":"{readStateIndex:2075; appliedIndex:2074; }","duration":"178.519877ms","start":"2026-10-26T19:21:04.495554Z","end":"2026-10-26T19:21:04.674074Z","steps":["trace[122900214] 'read index received'  (duration: 138.806962ms)","trace[122900214] 'applied index is now lower than readState.Index'  (duration: 39.712085ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:21:04.674213Z","caller":"traceutil/trace.go:171","msg":"trace[893890547] transaction","detail":"{read_only:false; response_revision:1998; number_of_response:1; }","duration":"198.411681ms","start":"2026-10-26T19:21:04.475786Z","end":"2026-10-26T19:21:04.674198Z","steps":["trace[893890547] 'process raft request'  (duration: 197.084816ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:21:04.674266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.712232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5700"}
{"level":"info","ts":"2026-10-26T19:21:04.67429Z","caller":"traceutil/trace.go:171","msg":"trace[216306099] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1998; }","duration":"178.794644ms","start":"2026-10-26T19:21:04.495488Z","end":"2026-10-26T19:21:04.674282Z","steps":["trace[216306099] 'agreement among raft nodes before linearized reading'  (duration: 178.671131ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:21:37.529848Z","caller":"traceutil/trace.go:171","msg":"trace[175401662] linearizableReadLoop","detail":"{readStateIndex:2263; appliedIndex:2262; }","duration":"133.187615ms","start":"2026-10-26T19:21:37.396615Z","end":"2026-10-26T19:21:37.529803Z","steps":["trace[175401662] 'read index received'  (duration: 95.203913ms)","trace[175401662] 'applied index is now lower than readState.Index'  (duration: 37.982321ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:21:37.529942Z","caller":"traceutil/trace.go:171","msg":"trace[793724637] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"145.820245ms","start":"2026-10-26T19:21:37.384037Z","end":"2026-10-26T19:21:37.529857Z","steps":["trace[793724637] 'process raft request'  (duration: 107.677869ms)","trace[793724637] 'compare'  (duration: 37.982852ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:21:37.530052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.424252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-10-26T19:21:37.530132Z","caller":"traceutil/trace.go:171","msg":"trace[1653865792] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2178; }","duration":"133.535184ms","start":"2026-10-26T19:21:37.39658Z","end":"2026-10-26T19:21:37.530115Z","steps":["trace[1653865792] 'agreement among raft nodes before linearized reading'  (duration: 133.348499ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:21:37.530187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.964751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-10-26T19:21:37.530245Z","caller":"traceutil/trace.go:171","msg":"trace[1118996123] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2178; }","duration":"115.039983ms","start":"2026-10-26T19:21:37.415188Z","end":"2026-10-26T19:21:37.530228Z","steps":["trace[1118996123] 'agreement among raft nodes before linearized reading'  (duration: 114.93539ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:21:43.022246Z","caller":"traceutil/trace.go:171","msg":"trace[1102845302] transaction","detail":"{read_only:false; response_revision:2207; number_of_response:1; }","duration":"138.467622ms","start":"2026-10-26T19:21:42.883733Z","end":"2026-10-26T19:21:43.022201Z","steps":["trace[1102845302] 'process raft request'  (duration: 138.177644ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:21:43.707081Z","caller":"traceutil/trace.go:171","msg":"trace[1959784627] linearizableReadLoop","detail":"{readStateIndex:2294; appliedIndex:2293; }","duration":"304.824166ms","start":"2026-10-26T19:21:43.40222Z","end":"2026-10-26T19:21:43.707044Z","steps":["trace[1959784627] 'read index received'  (duration: 304.523618ms)","trace[1959784627] 'applied index is now lower than readState.Index'  (duration: 298.758µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:21:43.707149Z","caller":"traceutil/trace.go:171","msg":"trace[693137592] transaction","detail":"{read_only:false; response_revision:2208; number_of_response:1; }","duration":"361.720271ms","start":"2026-10-26T19:21:43.345382Z","end":"2026-10-26T19:21:43.707102Z","steps":["trace[693137592] 'process raft request'  (duration: 361.369461ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:21:43.70732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.062433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:21:43.707368Z","caller":"traceutil/trace.go:171","msg":"trace[865242051] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:2208; }","duration":"305.178566ms","start":"2026-10-26T19:21:43.402172Z","end":"2026-10-26T19:21:43.707351Z","steps":["trace[865242051] 'agreement among raft nodes before linearized reading'  (duration: 305.065043ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:21:43.707356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:21:43.345347Z","time spent":"361.897826ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2197 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-10-26T19:21:43.707402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:21:43.402146Z","time spent":"305.244558ms","remote":"127.0.0.1:60652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true "}
{"level":"warn","ts":"2026-10-26T19:21:43.707623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.970132ms","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-10-26T19:21:43.707704Z","caller":"traceutil/trace.go:171","msg":"trace[1496798033] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2208; }","duration":"145.101906ms","start":"2026-10-26T19:21:43.562576Z","end":"2026-10-26T19:21:43.707678Z","steps":["trace[1496798033] 'agreement among raft nodes before linearized reading'  (duration: 144.683974ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:21:43.707737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.623506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-10-26T19:21:43.707726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.486959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-10-26T19:21:43.707785Z","caller":"traceutil/trace.go:171","msg":"trace[1191787393] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2208; }","duration":"138.706108ms","start":"2026-10-26T19:21:43.569064Z","end":"2026-10-26T19:21:43.70777Z","steps":["trace[1191787393] 'agreement among raft nodes before linearized reading'  (duration: 138.426071ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:21:43.707816Z","caller":"traceutil/trace.go:171","msg":"trace[710391641] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2208; }","duration":"131.598992ms","start":"2026-10-26T19:21:43.576182Z","end":"2026-10-26T19:21:43.707781Z","steps":["trace[710391641] 'agreement among raft nodes before linearized reading'  (duration: 131.268283ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:21:43.906361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.477776ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3113290786270970179 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:2201 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-26T19:21:43.90677Z","caller":"traceutil/trace.go:171","msg":"trace[1474156206] transaction","detail":"{read_only:false; response_revision:2212; number_of_response:1; }","duration":"188.457145ms","start":"2026-10-26T19:21:43.718289Z","end":"2026-10-26T19:21:43.906746Z","steps":["trace[1474156206] 'process raft request'  (duration: 188.295751ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:21:43.906814Z","caller":"traceutil/trace.go:171","msg":"trace[122643087] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"194.669837ms","start":"2026-10-26T19:21:43.712107Z","end":"2026-10-26T19:21:43.906777Z","steps":["trace[122643087] 'process raft request'  (duration: 74.698457ms)","trace[122643087] 'compare'  (duration: 119.385784ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:21:43.907056Z","caller":"traceutil/trace.go:171","msg":"trace[1511684831] transaction","detail":"{read_only:false; response_revision:2210; number_of_response:1; }","duration":"188.757344ms","start":"2026-10-26T19:21:43.71805Z","end":"2026-10-26T19:21:43.906807Z","steps":["trace[1511684831] 'process raft request'  (duration: 188.409444ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:21:43.907159Z","caller":"traceutil/trace.go:171","msg":"trace[2124264225] transaction","detail":"{read_only:false; response_revision:2211; number_of_response:1; }","duration":"188.796215ms","start":"2026-10-26T19:21:43.71812Z","end":"2026-10-26T19:21:43.906917Z","steps":["trace[2124264225] 'process raft request'  (duration: 188.421685ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:21:43.912957Z","caller":"traceutil/trace.go:171","msg":"trace[321811952] transaction","detail":"{read_only:false; response_revision:2213; number_of_response:1; }","duration":"111.538307ms","start":"2026-10-26T19:21:43.801388Z","end":"2026-10-26T19:21:43.912926Z","steps":["trace[321811952] 'process raft request'  (duration: 111.307751ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:22:18.953692Z","caller":"traceutil/trace.go:171","msg":"trace[1189240351] transaction","detail":"{read_only:false; response_revision:2576; number_of_response:1; }","duration":"322.586867ms","start":"2026-10-26T19:22:18.631084Z","end":"2026-10-26T19:22:18.95367Z","steps":["trace[1189240351] 'process raft request'  (duration: 322.447473ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:22:18.953853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:22:18.63105Z","time spent":"322.716961ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2562 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-10-26T19:22:56.933586Z","caller":"traceutil/trace.go:171","msg":"trace[1170585074] transaction","detail":"{read_only:false; response_revision:2805; number_of_response:1; }","duration":"108.747714ms","start":"2026-10-26T19:22:56.824815Z","end":"2026-10-26T19:22:56.933563Z","steps":["trace[1170585074] 'process raft request'  (duration: 108.58647ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:27:08.734027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.327276ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3113290786270977152 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/vector\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/vector\" value_size:957 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-10-26T19:27:08.734141Z","caller":"traceutil/trace.go:171","msg":"trace[1030805227] linearizableReadLoop","detail":"{readStateIndex:5241; appliedIndex:5240; }","duration":"417.887127ms","start":"2026-10-26T19:27:08.316241Z","end":"2026-10-26T19:27:08.734128Z","steps":["trace[1030805227] 'read index received'  (duration: 183.286753ms)","trace[1030805227] 'applied index is now lower than readState.Index'  (duration: 234.599224ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:27:08.73419Z","caller":"traceutil/trace.go:171","msg":"trace[224182166] transaction","detail":"{read_only:false; response_revision:5050; number_of_response:1; }","duration":"420.207451ms","start":"2026-10-26T19:27:08.313974Z","end":"2026-10-26T19:27:08.734182Z","steps":["trace[224182166] 'process raft request'  (duration: 185.652818ms)","trace[224182166] 'compare'  (duration: 234.1028ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:27:08.73422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:27:08.313956Z","time spent":"420.248682ms","remote":"127.0.0.1:52328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1001,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/vector\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/vector\" value_size:957 >> failure:<>"}
{"level":"warn","ts":"2026-10-26T19:27:08.734512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.253048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:27:08.734595Z","caller":"traceutil/trace.go:171","msg":"trace[1551379640] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5050; }","duration":"418.374761ms","start":"2026-10-26T19:27:08.316206Z","end":"2026-10-26T19:27:08.73458Z","steps":["trace[1551379640] 'agreement among raft nodes before linearized reading'  (duration: 417.99738ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:27:08.73463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:27:08.31619Z","time spent":"418.429883ms","remote":"127.0.0.1:51958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-10-26T19:27:08.745018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.839359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-68f650f9-f546-462a-91fa-211aed4a5f9c\" ","response":"range_response_count:1 size:3601"}
{"level":"warn","ts":"2026-10-26T19:27:08.745087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.859124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-26T19:27:08.745096Z","caller":"traceutil/trace.go:171","msg":"trace[31652580] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-68f650f9-f546-462a-91fa-211aed4a5f9c; range_end:; response_count:1; response_revision:5051; }","duration":"294.954652ms","start":"2026-10-26T19:27:08.450123Z","end":"2026-10-26T19:27:08.745078Z","steps":["trace[31652580] 'agreement among raft nodes before linearized reading'  (duration: 294.785797ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:27:08.745101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.830421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:414015"}
{"level":"info","ts":"2026-10-26T19:27:08.745114Z","caller":"traceutil/trace.go:171","msg":"trace[308301718] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:5051; }","duration":"281.909976ms","start":"2026-10-26T19:27:08.463192Z","end":"2026-10-26T19:27:08.745102Z","steps":["trace[308301718] 'agreement among raft nodes before linearized reading'  (duration: 281.867665ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:27:08.745131Z","caller":"traceutil/trace.go:171","msg":"trace[645940194] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:5051; }","duration":"241.892513ms","start":"2026-10-26T19:27:08.50323Z","end":"2026-10-26T19:27:08.745123Z","steps":["trace[645940194] 'agreement among raft nodes before linearized reading'  (duration: 241.749369ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:27:08.74502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.064635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-68f650f9-f546-462a-91fa-211aed4a5f9c\" ","response":"range_response_count:1 size:3601"}
{"level":"warn","ts":"2026-10-26T19:27:08.745213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.269114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:1229"}
{"level":"info","ts":"2026-10-26T19:27:08.745283Z","caller":"traceutil/trace.go:171","msg":"trace[427818738] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:5051; }","duration":"412.344816ms","start":"2026-10-26T19:27:08.332916Z","end":"2026-10-26T19:27:08.745261Z","steps":["trace[427818738] 'agreement among raft nodes before linearized reading'  (duration: 412.189082ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:27:08.745287Z","caller":"traceutil/trace.go:171","msg":"trace[32343702] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-68f650f9-f546-462a-91fa-211aed4a5f9c; range_end:; response_count:1; response_revision:5051; }","duration":"291.337493ms","start":"2026-10-26T19:27:08.453912Z","end":"2026-10-26T19:27:08.74525Z","steps":["trace[32343702] 'agreement among raft nodes before linearized reading'  (duration: 290.967973ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:27:08.745319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:27:08.332863Z","time spent":"412.446999ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1253,"request content":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager\" "}
{"level":"info","ts":"2026-10-26T19:27:11.003853Z","caller":"traceutil/trace.go:171","msg":"trace[2051083057] transaction","detail":"{read_only:false; response_revision:5096; number_of_response:1; }","duration":"231.930342ms","start":"2026-10-26T19:27:10.771903Z","end":"2026-10-26T19:27:11.003833Z","steps":["trace[2051083057] 'process raft request'  (duration: 231.828609ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:27:11.003878Z","caller":"traceutil/trace.go:171","msg":"trace[213657425] transaction","detail":"{read_only:false; response_revision:5095; number_of_response:1; }","duration":"233.043392ms","start":"2026-10-26T19:27:10.770808Z","end":"2026-10-26T19:27:11.003852Z","steps":["trace[213657425] 'process raft request'  (duration: 145.294177ms)","trace[213657425] 'compare'  (duration: 87.464457ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:27:19.212857Z","caller":"traceutil/trace.go:171","msg":"trace[499694543] transaction","detail":"{read_only:false; response_revision:5244; number_of_response:1; }","duration":"157.236572ms","start":"2026-10-26T19:27:19.055597Z","end":"2026-10-26T19:27:19.212834Z","steps":["trace[499694543] 'process raft request'  (duration: 157.092878ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:27:19.216002Z","caller":"traceutil/trace.go:171","msg":"trace[1496555715] transaction","detail":"{read_only:false; response_revision:5245; number_of_response:1; }","duration":"138.495621ms","start":"2026-10-26T19:27:19.07749Z","end":"2026-10-26T19:27:19.215986Z","steps":["trace[1496555715] 'process raft request'  (duration: 138.370568ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:27:19.216172Z","caller":"traceutil/trace.go:171","msg":"trace[516269039] linearizableReadLoop","detail":"{readStateIndex:5443; appliedIndex:5441; }","duration":"137.698378ms","start":"2026-10-26T19:27:19.078453Z","end":"2026-10-26T19:27:19.216151Z","steps":["trace[516269039] 'read index received'  (duration: 134.239624ms)","trace[516269039] 'applied index is now lower than readState.Index'  (duration: 3.457674ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:27:19.216304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.829133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:27:19.216337Z","caller":"traceutil/trace.go:171","msg":"trace[260102662] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:5246; }","duration":"137.899134ms","start":"2026-10-26T19:27:19.078429Z","end":"2026-10-26T19:27:19.216328Z","steps":["trace[260102662] 'agreement among raft nodes before linearized reading'  (duration: 137.801962ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:27:28.944173Z","caller":"traceutil/trace.go:171","msg":"trace[1091692637] linearizableReadLoop","detail":"{readStateIndex:5638; appliedIndex:5637; }","duration":"283.426706ms","start":"2026-10-26T19:27:28.660714Z","end":"2026-10-26T19:27:28.94414Z","steps":["trace[1091692637] 'read index received'  (duration: 283.085457ms)","trace[1091692637] 'applied index is now lower than readState.Index'  (duration: 339.919µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:27:28.944297Z","caller":"traceutil/trace.go:171","msg":"trace[965196393] transaction","detail":"{read_only:false; response_revision:5437; number_of_response:1; }","duration":"285.593286ms","start":"2026-10-26T19:27:28.658671Z","end":"2026-10-26T19:27:28.944264Z","steps":["trace[965196393] 'process raft request'  (duration: 285.228376ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:27:28.944534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.792206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-68f650f9-f546-462a-91fa-211aed4a5f9c\" ","response":"range_response_count:1 size:1275"}
{"level":"info","ts":"2026-10-26T19:27:28.94459Z","caller":"traceutil/trace.go:171","msg":"trace[1398650923] range","detail":"{range_begin:/registry/persistentvolumes/pvc-68f650f9-f546-462a-91fa-211aed4a5f9c; range_end:; response_count:1; response_revision:5437; }","duration":"283.889319ms","start":"2026-10-26T19:27:28.660684Z","end":"2026-10-26T19:27:28.944574Z","steps":["trace[1398650923] 'agreement among raft nodes before linearized reading'  (duration: 283.650933ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:27:28.944583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.808738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-af17674a-3abe-4038-ad16-900db63311f8\" ","response":"range_response_count:1 size:3766"}
{"level":"warn","ts":"2026-10-26T19:27:28.94462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.135161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:27:28.944753Z","caller":"traceutil/trace.go:171","msg":"trace[1500421800] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:5437; }","duration":"271.356807ms","start":"2026-10-26T19:27:28.67337Z","end":"2026-10-26T19:27:28.944726Z","steps":["trace[1500421800] 'agreement among raft nodes before linearized reading'  (duration: 271.09979ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:27:28.944841Z","caller":"traceutil/trace.go:171","msg":"trace[1161137573] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-af17674a-3abe-4038-ad16-900db63311f8; range_end:; response_count:1; response_revision:5437; }","duration":"231.92344ms","start":"2026-10-26T19:27:28.712691Z","end":"2026-10-26T19:27:28.944614Z","steps":["trace[1161137573] 'agreement among raft nodes before linearized reading'  (duration: 231.808127ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:27:29.138296Z","caller":"traceutil/trace.go:171","msg":"trace[1128875675] transaction","detail":"{read_only:false; response_revision:5438; number_of_response:1; }","duration":"181.401321ms","start":"2026-10-26T19:27:28.956855Z","end":"2026-10-26T19:27:29.138256Z","steps":["trace[1128875675] 'process raft request'  (duration: 137.357589ms)","trace[1128875675] 'compare'  (duration: 43.814676ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:27:29.660154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.064216ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3113290786270978047 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/monitoring/loki-headless-wd5bh\" mod_revision:0 > success:<request_put:<key:\"/registry/endpointslices/monitoring/loki-headless-wd5bh\" value_size:1398 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-10-26T19:27:29.660421Z","caller":"traceutil/trace.go:171","msg":"trace[1698261622] transaction","detail":"{read_only:false; response_revision:5441; number_of_response:1; }","duration":"515.704578ms","start":"2026-10-26T19:27:29.144659Z","end":"2026-10-26T19:27:29.660363Z","steps":["trace[1698261622] 'process raft request'  (duration: 515.577315ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:27:29.660471Z","caller":"traceutil/trace.go:171","msg":"trace[289957016] transaction","detail":"{read_only:false; response_revision:5446; number_of_response:1; }","duration":"140.174277ms","start":"2026-10-26T19:27:29.520284Z","end":"2026-10-26T19:27:29.660458Z","steps":["trace[289957016] 'process raft request'  (duration: 140.137256ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:27:29.660589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:27:29.14464Z","time spent":"515.854562ms","remote":"127.0.0.1:52136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/monitoring/loki-memberlist\" mod_revision:4926 > success:<request_put:<key:\"/registry/services/endpoints/monitoring/loki-memberlist\" value_size:902 >> failure:<request_range:<key:\"/registry/services/endpoints/monitoring/loki-memberlist\" > >"}
{"level":"info","ts":"2026-10-26T19:27:29.660577Z","caller":"traceutil/trace.go:171","msg":"trace[770031244] transaction","detail":"{read_only:false; response_revision:5440; number_of_response:1; }","duration":"516.068098ms","start":"2026-10-26T19:27:29.144467Z","end":"2026-10-26T19:27:29.660535Z","steps":["trace[770031244] 'process raft request'  (duration: 409.56228ms)","trace[770031244] 'compare'  (duration: 105.720976ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:27:29.66064Z","caller":"traceutil/trace.go:171","msg":"trace[1252280712] transaction","detail":"{read_only:false; response_revision:5444; number_of_response:1; }","duration":"515.646616ms","start":"2026-10-26T19:27:29.144985Z","end":"2026-10-26T19:27:29.660631Z","steps":["trace[1252280712] 'process raft request'  (duration: 515.355858ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:27:29.660695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:27:29.144968Z","time spent":"515.689827ms","remote":"127.0.0.1:52136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1080,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/monitoring/loki-headless\" mod_revision:5176 > success:<request_put:<key:\"/registry/services/endpoints/monitoring/loki-headless\" value_size:1019 >> failure:<request_range:<key:\"/registry/services/endpoints/monitoring/loki-headless\" > >"}
{"level":"info","ts":"2026-10-26T19:27:29.660793Z","caller":"traceutil/trace.go:171","msg":"trace[1745418990] linearizableReadLoop","detail":"{readStateIndex:5645; appliedIndex:5640; }","duration":"450.965161ms","start":"2026-10-26T19:27:29.20982Z","end":"2026-10-26T19:27:29.660786Z","steps":["trace[1745418990] 'read index received'  (duration: 344.216007ms)","trace[1745418990] 'applied index is now lower than readState.Index'  (duration: 106.748284ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:27:29.660793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:27:29.144434Z","time spent":"516.243313ms","remote":"127.0.0.1:52248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1461,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/endpointslices/monitoring/loki-headless-wd5bh\" mod_revision:0 > success:<request_put:<key:\"/registry/endpointslices/monitoring/loki-headless-wd5bh\" value_size:1398 >> failure:<>"}
{"level":"info","ts":"2026-10-26T19:27:29.660906Z","caller":"traceutil/trace.go:171","msg":"trace[28529189] transaction","detail":"{read_only:false; response_revision:5445; number_of_response:1; }","duration":"403.095784ms","start":"2026-10-26T19:27:29.257804Z","end":"2026-10-26T19:27:29.6609Z","steps":["trace[28529189] 'process raft request'  (duration: 402.567059ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:27:29.660947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:27:29.257784Z","time spent":"403.140405ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:5368 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:457 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-10-26T19:27:29.661023Z","caller":"traceutil/trace.go:171","msg":"trace[361874943] transaction","detail":"{read_only:false; response_revision:5442; number_of_response:1; }","duration":"516.324394ms","start":"2026-10-26T19:27:29.144672Z","end":"2026-10-26T19:27:29.660997Z","steps":["trace[361874943] 'process raft request'  (duration: 515.615855ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:27:29.661079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.262128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:27:29.661127Z","caller":"traceutil/trace.go:171","msg":"trace[520973484] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:5446; }","duration":"451.334351ms","start":"2026-10-26T19:27:29.209763Z","end":"2026-10-26T19:27:29.661098Z","steps":["trace[520973484] 'agreement among raft nodes before linearized reading'  (duration: 451.28826ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:27:29.661146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:27:29.209741Z","time spent":"451.400102ms","remote":"127.0.0.1:60712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true "}
{"level":"warn","ts":"2026-10-26T19:27:29.661161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:27:29.144646Z","time spent":"516.425117ms","remote":"127.0.0.1:52248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1496,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/endpointslices/monitoring/loki-memberlist-vg278\" mod_revision:4927 > success:<request_put:<key:\"/registry/endpointslices/monitoring/loki-memberlist-vg278\" value_size:1431 >> failure:<request_range:<key:\"/registry/endpointslices/monitoring/loki-memberlist-vg278\" > >"}
{"level":"info","ts":"2026-10-26T19:27:29.660547Z","caller":"traceutil/trace.go:171","msg":"trace[951104421] transaction","detail":"{read_only:false; response_revision:5443; number_of_response:1; }","duration":"515.485842ms","start":"2026-10-26T19:27:29.144981Z","end":"2026-10-26T19:27:29.660467Z","steps":["trace[951104421] 'process raft request'  (duration: 515.332968ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:27:29.661285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:27:29.144963Z","time spent":"516.298454ms","remote":"127.0.0.1:52136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":895,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/monitoring/loki\" mod_revision:4941 > success:<request_put:<key:\"/registry/services/endpoints/monitoring/loki\" value_size:843 >> failure:<request_range:<key:\"/registry/services/endpoints/monitoring/loki\" > >"}
{"level":"warn","ts":"2026-10-26T19:27:29.667417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.540399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-26T19:27:29.667582Z","caller":"traceutil/trace.go:171","msg":"trace[430862779] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:5447; }","duration":"102.746494ms","start":"2026-10-26T19:27:29.564806Z","end":"2026-10-26T19:27:29.667552Z","steps":["trace[430862779] 'agreement among raft nodes before linearized reading'  (duration: 102.460917ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:27:29.667622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.170674ms","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-10-26T19:27:29.667677Z","caller":"traceutil/trace.go:171","msg":"trace[258113520] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5447; }","duration":"389.291357ms","start":"2026-10-26T19:27:29.278369Z","end":"2026-10-26T19:27:29.667661Z","steps":["trace[258113520] 'agreement among raft nodes before linearized reading'  (duration: 388.680201ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:27:29.667728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:27:29.278348Z","time spent":"389.367279ms","remote":"127.0.0.1:52234","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-10-26T19:27:43.870596Z","caller":"traceutil/trace.go:171","msg":"trace[1320017352] linearizableReadLoop","detail":"{readStateIndex:5835; appliedIndex:5833; }","duration":"118.35452ms","start":"2026-10-26T19:27:43.752213Z","end":"2026-10-26T19:27:43.870567Z","steps":["trace[1320017352] 'read index received'  (duration: 66.69377ms)","trace[1320017352] 'applied index is now lower than readState.Index'  (duration: 51.65946ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:27:43.870696Z","caller":"traceutil/trace.go:171","msg":"trace[724920620] transaction","detail":"{read_only:false; response_revision:5627; number_of_response:1; }","duration":"163.075771ms","start":"2026-10-26T19:27:43.707593Z","end":"2026-10-26T19:27:43.870669Z","steps":["trace[724920620] 'process raft request'  (duration: 111.346259ms)","trace[724920620] 'compare'  (duration: 51.360192ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:27:43.870793Z","caller":"traceutil/trace.go:171","msg":"trace[2120094404] transaction","detail":"{read_only:false; response_revision:5628; number_of_response:1; }","duration":"157.13975ms","start":"2026-10-26T19:27:43.713627Z","end":"2026-10-26T19:27:43.870766Z","steps":["trace[2120094404] 'process raft request'  (duration: 156.881823ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:27:43.870867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.627259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:27:43.870918Z","caller":"traceutil/trace.go:171","msg":"trace[1399270587] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5628; }","duration":"118.732402ms","start":"2026-10-26T19:27:43.75217Z","end":"2026-10-26T19:27:43.870902Z","steps":["trace[1399270587] 'agreement among raft nodes before linearized reading'  (duration: 118.625479ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:27:44.015953Z","caller":"traceutil/trace.go:171","msg":"trace[2109518812] transaction","detail":"{read_only:false; response_revision:5630; number_of_response:1; }","duration":"135.410837ms","start":"2026-10-26T19:27:43.88049Z","end":"2026-10-26T19:27:44.015901Z","steps":["trace[2109518812] 'process raft request'  (duration: 104.207765ms)","trace[2109518812] 'compare'  (duration: 30.869643ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:28:16.605448Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2915}
{"level":"info","ts":"2026-10-26T19:28:16.684923Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2915,"took":"78.092359ms","hash":3632944149,"current-db-size-bytes":56811520,"current-db-size":"57 MB","current-db-size-in-use-bytes":33619968,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-10-26T19:28:16.68499Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3632944149,"revision":2915,"compact-revision":-1}
{"level":"info","ts":"2026-10-26T19:33:16.61272Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5953}
{"level":"info","ts":"2026-10-26T19:33:16.72105Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5953,"took":"106.000522ms","hash":2618453502,"current-db-size-bytes":56811520,"current-db-size":"57 MB","current-db-size-in-use-bytes":21643264,"current-db-size-in-use":"22 MB"}
{"level":"info","ts":"2026-10-26T19:33:16.72113Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2618453502,"revision":5953,"compact-revision":2915}
{"level":"info","ts":"2026-10-26T19:33:38.324289Z","caller":"traceutil/trace.go:171","msg":"trace[868334656] linearizableReadLoop","detail":"{readStateIndex:8620; appliedIndex:8619; }","duration":"379.345323ms","start":"2026-10-26T19:33:37.944909Z","end":"2026-10-26T19:33:38.324254Z","steps":["trace[868334656] 'read index received'  (duration: 379.041935ms)","trace[868334656] 'applied index is now lower than readState.Index'  (duration: 302.338µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:33:38.324331Z","caller":"traceutil/trace.go:171","msg":"trace[2058644352] transaction","detail":"{read_only:false; response_revision:8324; number_of_response:1; }","duration":"484.736979ms","start":"2026-10-26T19:33:37.839567Z","end":"2026-10-26T19:33:38.324304Z","steps":["trace[2058644352] 'process raft request'  (duration: 484.456891ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:33:38.324519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.60183ms","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":"warn","ts":"2026-10-26T19:33:38.324548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:33:37.83955Z","time spent":"484.910144ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:8133 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-10-26T19:33:38.324571Z","caller":"traceutil/trace.go:171","msg":"trace[1127837219] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8324; }","duration":"379.695573ms","start":"2026-10-26T19:33:37.944865Z","end":"2026-10-26T19:33:38.32456Z","steps":["trace[1127837219] 'agreement among raft nodes before linearized reading'  (duration: 379.531238ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:33:38.324603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:33:37.944848Z","time spent":"379.746095ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-10-26T19:33:38.324595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.411916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-26T19:33:38.324736Z","caller":"traceutil/trace.go:171","msg":"trace[1076448673] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:8324; }","duration":"343.592671ms","start":"2026-10-26T19:33:37.981117Z","end":"2026-10-26T19:33:38.32471Z","steps":["trace[1076448673] 'agreement among raft nodes before linearized reading'  (duration: 343.408266ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:33:38.324797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:33:37.981097Z","time spent":"343.683384ms","remote":"127.0.0.1:52222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":2,"response size":31,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "}
{"level":"warn","ts":"2026-10-26T19:33:38.324882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.908365ms","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-10-26T19:33:38.32493Z","caller":"traceutil/trace.go:171","msg":"trace[511931299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8324; }","duration":"194.992448ms","start":"2026-10-26T19:33:38.129929Z","end":"2026-10-26T19:33:38.324921Z","steps":["trace[511931299] 'agreement among raft nodes before linearized reading'  (duration: 194.890775ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:33:38.324871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.784584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12432"}
{"level":"info","ts":"2026-10-26T19:33:38.325011Z","caller":"traceutil/trace.go:171","msg":"trace[98436335] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8324; }","duration":"225.954389ms","start":"2026-10-26T19:33:38.099047Z","end":"2026-10-26T19:33:38.325001Z","steps":["trace[98436335] 'agreement among raft nodes before linearized reading'  (duration: 225.691912ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:33:38.325045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.690053ms","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-10-26T19:33:38.325117Z","caller":"traceutil/trace.go:171","msg":"trace[1454861332] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8324; }","duration":"240.795826ms","start":"2026-10-26T19:33:38.084302Z","end":"2026-10-26T19:33:38.325097Z","steps":["trace[1454861332] 'agreement among raft nodes before linearized reading'  (duration: 240.639892ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:33:49.974535Z","caller":"traceutil/trace.go:171","msg":"trace[1952846880] transaction","detail":"{read_only:false; response_revision:8384; number_of_response:1; }","duration":"190.631928ms","start":"2026-10-26T19:33:49.783866Z","end":"2026-10-26T19:33:49.974498Z","steps":["trace[1952846880] 'process raft request'  (duration: 164.070978ms)","trace[1952846880] 'compare'  (duration: 25.933163ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:33:50.602693Z","caller":"traceutil/trace.go:171","msg":"trace[692091342] linearizableReadLoop","detail":"{readStateIndex:8691; appliedIndex:8688; }","duration":"177.2438ms","start":"2026-10-26T19:33:50.425429Z","end":"2026-10-26T19:33:50.602673Z","steps":["trace[692091342] 'read index received'  (duration: 81.15185ms)","trace[692091342] 'applied index is now lower than readState.Index'  (duration: 96.09122ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:33:50.602783Z","caller":"traceutil/trace.go:171","msg":"trace[1565376187] transaction","detail":"{read_only:false; response_revision:8391; number_of_response:1; }","duration":"180.52127ms","start":"2026-10-26T19:33:50.422253Z","end":"2026-10-26T19:33:50.602774Z","steps":["trace[1565376187] 'process raft request'  (duration: 180.359355ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:33:50.602838Z","caller":"traceutil/trace.go:171","msg":"trace[1279629456] transaction","detail":"{read_only:false; response_revision:8390; number_of_response:1; }","duration":"180.86953ms","start":"2026-10-26T19:33:50.421907Z","end":"2026-10-26T19:33:50.602776Z","steps":["trace[1279629456] 'process raft request'  (duration: 84.662436ms)","trace[1279629456] 'compare'  (duration: 95.924006ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:33:50.602945Z","caller":"traceutil/trace.go:171","msg":"trace[1737948841] transaction","detail":"{read_only:false; response_revision:8392; number_of_response:1; }","duration":"180.604662ms","start":"2026-10-26T19:33:50.422334Z","end":"2026-10-26T19:33:50.602939Z","steps":["trace[1737948841] 'process raft request'  (duration: 180.313394ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:33:50.603112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.681962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-10-26T19:33:50.603138Z","caller":"traceutil/trace.go:171","msg":"trace[1627886226] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8392; }","duration":"177.761114ms","start":"2026-10-26T19:33:50.42537Z","end":"2026-10-26T19:33:50.603132Z","steps":["trace[1627886226] 'agreement among raft nodes before linearized reading'  (duration: 177.644721ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:33:50.644462Z","caller":"traceutil/trace.go:171","msg":"trace[1831413939] transaction","detail":"{read_only:false; response_revision:8393; number_of_response:1; }","duration":"122.597599ms","start":"2026-10-26T19:33:50.521849Z","end":"2026-10-26T19:33:50.644447Z","steps":["trace[1831413939] 'process raft request'  (duration: 122.518356ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:33:50.644683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.758813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-2ztw2\" ","response":"range_response_count:1 size:6531"}
{"level":"info","ts":"2026-10-26T19:33:50.64475Z","caller":"traceutil/trace.go:171","msg":"trace[1655866943] range","detail":"{range_begin:/registry/pods/openstack/keepalived-2ztw2; range_end:; response_count:1; response_revision:8393; }","duration":"217.867686ms","start":"2026-10-26T19:33:50.426865Z","end":"2026-10-26T19:33:50.644732Z","steps":["trace[1655866943] 'agreement among raft nodes before linearized reading'  (duration: 217.64136ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:33:50.940683Z","caller":"traceutil/trace.go:171","msg":"trace[1199608463] linearizableReadLoop","detail":"{readStateIndex:8693; appliedIndex:8692; }","duration":"291.226241ms","start":"2026-10-26T19:33:50.649428Z","end":"2026-10-26T19:33:50.940654Z","steps":["trace[1199608463] 'read index received'  (duration: 273.482784ms)","trace[1199608463] 'applied index is now lower than readState.Index'  (duration: 17.742057ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:33:50.940819Z","caller":"traceutil/trace.go:171","msg":"trace[1309547200] transaction","detail":"{read_only:false; response_revision:8394; number_of_response:1; }","duration":"333.846403ms","start":"2026-10-26T19:33:50.60695Z","end":"2026-10-26T19:33:50.940796Z","steps":["trace[1309547200] 'process raft request'  (duration: 316.040134ms)","trace[1309547200] 'compare'  (duration: 17.514111ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:33:50.940962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:33:50.606925Z","time spent":"333.966946ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8379 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-10-26T19:33:50.941251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.843408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:225053"}
{"level":"info","ts":"2026-10-26T19:33:50.941307Z","caller":"traceutil/trace.go:171","msg":"trace[1102809680] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8394; }","duration":"291.943952ms","start":"2026-10-26T19:33:50.649349Z","end":"2026-10-26T19:33:50.941293Z","steps":["trace[1102809680] 'agreement among raft nodes before linearized reading'  (duration: 291.452989ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:33:51.576848Z","caller":"traceutil/trace.go:171","msg":"trace[146407294] transaction","detail":"{read_only:false; response_revision:8396; number_of_response:1; }","duration":"175.06265ms","start":"2026-10-26T19:33:51.401765Z","end":"2026-10-26T19:33:51.576828Z","steps":["trace[146407294] 'process raft request'  (duration: 174.921017ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:33:51.828829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.666689ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3113290786270985899 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8382 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-26T19:33:51.828926Z","caller":"traceutil/trace.go:171","msg":"trace[2006917529] linearizableReadLoop","detail":"{readStateIndex:8696; appliedIndex:8694; }","duration":"331.89342ms","start":"2026-10-26T19:33:51.497017Z","end":"2026-10-26T19:33:51.82891Z","steps":["trace[2006917529] 'read index received'  (duration: 79.68094ms)","trace[2006917529] 'applied index is now lower than readState.Index'  (duration: 252.21126ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:33:51.829009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.986542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-26T19:33:51.829037Z","caller":"traceutil/trace.go:171","msg":"trace[1838564963] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:8397; }","duration":"332.054824ms","start":"2026-10-26T19:33:51.496973Z","end":"2026-10-26T19:33:51.829028Z","steps":["trace[1838564963] 'agreement among raft nodes before linearized reading'  (duration: 331.975972ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:33:51.829072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:33:51.496947Z","time spent":"332.117245ms","remote":"127.0.0.1:44800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":31,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true "}
{"level":"info","ts":"2026-10-26T19:33:51.829061Z","caller":"traceutil/trace.go:171","msg":"trace[136249860] transaction","detail":"{read_only:false; response_revision:8397; number_of_response:1; }","duration":"421.255295ms","start":"2026-10-26T19:33:51.407772Z","end":"2026-10-26T19:33:51.829028Z","steps":["trace[136249860] 'process raft request'  (duration: 238.312119ms)","trace[136249860] 'compare'  (duration: 182.466843ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:33:51.82928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:33:51.407755Z","time spent":"421.401828ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:8382 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-26T19:33:51.86749Z","caller":"traceutil/trace.go:171","msg":"trace[216256677] transaction","detail":"{read_only:false; response_revision:8398; number_of_response:1; }","duration":"104.863641ms","start":"2026-10-26T19:33:51.762597Z","end":"2026-10-26T19:33:51.867461Z","steps":["trace[216256677] 'process raft request'  (duration: 104.663495ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:34:24.146434Z","caller":"traceutil/trace.go:171","msg":"trace[109585834] transaction","detail":"{read_only:false; response_revision:8622; number_of_response:1; }","duration":"127.985217ms","start":"2026-10-26T19:34:24.018424Z","end":"2026-10-26T19:34:24.146409Z","steps":["trace[109585834] 'process raft request'  (duration: 127.826622ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:34:24.15741Z","caller":"traceutil/trace.go:171","msg":"trace[1939788999] transaction","detail":"{read_only:false; response_revision:8623; number_of_response:1; }","duration":"136.078679ms","start":"2026-10-26T19:34:24.021305Z","end":"2026-10-26T19:34:24.157384Z","steps":["trace[1939788999] 'process raft request'  (duration: 135.923735ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:34:34.832656Z","caller":"traceutil/trace.go:171","msg":"trace[155003871] linearizableReadLoop","detail":"{readStateIndex:8996; appliedIndex:8995; }","duration":"178.196746ms","start":"2026-10-26T19:34:34.654442Z","end":"2026-10-26T19:34:34.832638Z","steps":["trace[155003871] 'read index received'  (duration: 172.341006ms)","trace[155003871] 'applied index is now lower than readState.Index'  (duration: 5.85464ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:34:34.832862Z","caller":"traceutil/trace.go:171","msg":"trace[1627663884] transaction","detail":"{read_only:false; response_revision:8687; number_of_response:1; }","duration":"189.059364ms","start":"2026-10-26T19:34:34.643794Z","end":"2026-10-26T19:34:34.832853Z","steps":["trace[1627663884] 'process raft request'  (duration: 182.949217ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:34:34.833094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.641399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:6011"}
{"level":"info","ts":"2026-10-26T19:34:34.833129Z","caller":"traceutil/trace.go:171","msg":"trace[153154183] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:8687; }","duration":"178.718421ms","start":"2026-10-26T19:34:34.6544Z","end":"2026-10-26T19:34:34.833118Z","steps":["trace[153154183] 'agreement among raft nodes before linearized reading'  (duration: 178.599277ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:34:34.833344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.064775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-10-26T19:34:34.833374Z","caller":"traceutil/trace.go:171","msg":"trace[2760022] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8687; }","duration":"106.143886ms","start":"2026-10-26T19:34:34.727224Z","end":"2026-10-26T19:34:34.833367Z","steps":["trace[2760022] 'agreement among raft nodes before linearized reading'  (duration: 106.063104ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:34:58.688543Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002418.wal"}
{"level":"info","ts":"2026-10-26T19:35:59.878249Z","caller":"traceutil/trace.go:171","msg":"trace[838807123] transaction","detail":"{read_only:false; response_revision:9516; number_of_response:1; }","duration":"182.326263ms","start":"2026-10-26T19:35:59.695896Z","end":"2026-10-26T19:35:59.878222Z","steps":["trace[838807123] 'process raft request'  (duration: 182.099497ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:36:00.041762Z","caller":"traceutil/trace.go:171","msg":"trace[258297458] linearizableReadLoop","detail":"{readStateIndex:9852; appliedIndex:9851; }","duration":"159.169888ms","start":"2026-10-26T19:35:59.882565Z","end":"2026-10-26T19:36:00.041735Z","steps":["trace[258297458] 'read index received'  (duration: 133.923745ms)","trace[258297458] 'applied index is now lower than readState.Index'  (duration: 25.244843ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:36:00.041869Z","caller":"traceutil/trace.go:171","msg":"trace[1639224358] transaction","detail":"{read_only:false; response_revision:9517; number_of_response:1; }","duration":"161.189043ms","start":"2026-10-26T19:35:59.880644Z","end":"2026-10-26T19:36:00.041833Z","steps":["trace[1639224358] 'process raft request'  (duration: 135.828568ms)","trace[1639224358] 'compare'  (duration: 24.863962ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:36:00.042247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.666262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:31 size:293354"}
{"level":"info","ts":"2026-10-26T19:36:00.042289Z","caller":"traceutil/trace.go:171","msg":"trace[572273007] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:31; response_revision:9517; }","duration":"159.760705ms","start":"2026-10-26T19:35:59.882519Z","end":"2026-10-26T19:36:00.042279Z","steps":["trace[572273007] 'agreement among raft nodes before linearized reading'  (duration: 159.358434ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:36:00.19147Z","caller":"traceutil/trace.go:171","msg":"trace[974824505] transaction","detail":"{read_only:false; response_revision:9518; number_of_response:1; }","duration":"129.656027ms","start":"2026-10-26T19:36:00.061777Z","end":"2026-10-26T19:36:00.191433Z","steps":["trace[974824505] 'process raft request'  (duration: 111.984992ms)","trace[974824505] 'compare'  (duration: 17.516701ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:36:16.605471Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a656331365382b34","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-26T19:36:16.613264Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-10-26T19:36:16.613403Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-10-26T19:38:16.620897Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8036}
{"level":"info","ts":"2026-10-26T19:38:16.688569Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8036,"took":"64.994819ms","hash":3945629926,"current-db-size-bytes":56811520,"current-db-size":"57 MB","current-db-size-in-use-bytes":29036544,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-10-26T19:38:16.688668Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3945629926,"revision":8036,"compact-revision":5953}
{"level":"warn","ts":"2026-10-26T19:39:27.59608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.302529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:39:27.596217Z","caller":"traceutil/trace.go:171","msg":"trace[249937882] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:11274; }","duration":"111.490294ms","start":"2026-10-26T19:39:27.484704Z","end":"2026-10-26T19:39:27.596194Z","steps":["trace[249937882] 'count revisions from in-memory index tree'  (duration: 111.165495ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:43:16.628328Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10546}
{"level":"info","ts":"2026-10-26T19:43:16.714937Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10546,"took":"84.848502ms","hash":3520645216,"current-db-size-bytes":56811520,"current-db-size":"57 MB","current-db-size-in-use-bytes":27238400,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-10-26T19:43:16.714992Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3520645216,"revision":10546,"compact-revision":8036}
{"level":"info","ts":"2026-10-26T19:45:42.646673Z","caller":"traceutil/trace.go:171","msg":"trace[1622351927] linearizableReadLoop","detail":"{readStateIndex:14274; appliedIndex:14273; }","duration":"136.219567ms","start":"2026-10-26T19:45:42.510427Z","end":"2026-10-26T19:45:42.646647Z","steps":["trace[1622351927] 'read index received'  (duration: 133.599126ms)","trace[1622351927] 'applied index is now lower than readState.Index'  (duration: 2.619281ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:45:42.646729Z","caller":"traceutil/trace.go:171","msg":"trace[757106199] transaction","detail":"{read_only:false; response_revision:13800; number_of_response:1; }","duration":"137.838251ms","start":"2026-10-26T19:45:42.508848Z","end":"2026-10-26T19:45:42.646686Z","steps":["trace[757106199] 'process raft request'  (duration: 135.283112ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:45:42.647008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.563696ms","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-10-26T19:45:42.647092Z","caller":"traceutil/trace.go:171","msg":"trace[2020859364] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13800; }","duration":"136.67996ms","start":"2026-10-26T19:45:42.510392Z","end":"2026-10-26T19:45:42.647072Z","steps":["trace[2020859364] 'agreement among raft nodes before linearized reading'  (duration: 136.488155ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:46:20.796365Z","caller":"traceutil/trace.go:171","msg":"trace[621367264] linearizableReadLoop","detail":"{readStateIndex:14498; appliedIndex:14497; }","duration":"198.476575ms","start":"2026-10-26T19:46:20.59786Z","end":"2026-10-26T19:46:20.796337Z","steps":["trace[621367264] 'read index received'  (duration: 198.31499ms)","trace[621367264] 'applied index is now lower than readState.Index'  (duration: 160.275µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:46:20.796431Z","caller":"traceutil/trace.go:171","msg":"trace[1718556075] transaction","detail":"{read_only:false; response_revision:14014; number_of_response:1; }","duration":"521.964489ms","start":"2026-10-26T19:46:20.27442Z","end":"2026-10-26T19:46:20.796385Z","steps":["trace[1718556075] 'process raft request'  (duration: 521.728053ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:46:20.796743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.828464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-10-26T19:46:20.796811Z","caller":"traceutil/trace.go:171","msg":"trace[1725881035] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14014; }","duration":"198.969008ms","start":"2026-10-26T19:46:20.597824Z","end":"2026-10-26T19:46:20.796793Z","steps":["trace[1725881035] 'agreement among raft nodes before linearized reading'  (duration: 198.721301ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:46:20.797056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.439779ms","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-10-26T19:46:20.797378Z","caller":"traceutil/trace.go:171","msg":"trace[1051053855] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14014; }","duration":"136.826059ms","start":"2026-10-26T19:46:20.660541Z","end":"2026-10-26T19:46:20.797367Z","steps":["trace[1051053855] 'agreement among raft nodes before linearized reading'  (duration: 136.213802ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:46:20.797621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:20.274399Z","time spent":"522.139064ms","remote":"127.0.0.1:52158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12483,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/openvswitch-x597p\" mod_revision:14007 > success:<request_put:<key:\"/registry/pods/openstack/openvswitch-x597p\" value_size:12433 >> failure:<request_range:<key:\"/registry/pods/openstack/openvswitch-x597p\" > >"}
{"level":"warn","ts":"2026-10-26T19:46:33.160564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.63937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"}
{"level":"info","ts":"2026-10-26T19:46:33.16066Z","caller":"traceutil/trace.go:171","msg":"trace[1011726615] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:14121; }","duration":"117.759154ms","start":"2026-10-26T19:46:33.04288Z","end":"2026-10-26T19:46:33.160639Z","steps":["trace[1011726615] 'agreement among raft nodes before linearized reading'  (duration: 117.565968ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:46:45.0088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.085797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-26T19:46:45.008922Z","caller":"traceutil/trace.go:171","msg":"trace[690581624] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:14337; }","duration":"150.261372ms","start":"2026-10-26T19:46:44.858637Z","end":"2026-10-26T19:46:45.008899Z","steps":["trace[690581624] 'count revisions from in-memory index tree'  (duration: 149.994145ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:46:45.877881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.684697ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3113290786271002735 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:14266 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-26T19:46:45.878156Z","caller":"traceutil/trace.go:171","msg":"trace[1005920322] linearizableReadLoop","detail":"{readStateIndex:14836; appliedIndex:14833; }","duration":"779.159692ms","start":"2026-10-26T19:46:45.098977Z","end":"2026-10-26T19:46:45.878136Z","steps":["trace[1005920322] 'read index received'  (duration: 50.056243ms)","trace[1005920322] 'applied index is now lower than readState.Index'  (duration: 729.102549ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:46:45.878128Z","caller":"traceutil/trace.go:171","msg":"trace[1324796408] transaction","detail":"{read_only:false; response_revision:14339; number_of_response:1; }","duration":"780.23801ms","start":"2026-10-26T19:46:45.097845Z","end":"2026-10-26T19:46:45.878083Z","steps":["trace[1324796408] 'process raft request'  (duration: 51.250295ms)","trace[1324796408] 'compare'  (duration: 728.337268ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:46:45.87818Z","caller":"traceutil/trace.go:171","msg":"trace[267743935] transaction","detail":"{read_only:false; response_revision:14340; number_of_response:1; }","duration":"779.8556ms","start":"2026-10-26T19:46:45.098288Z","end":"2026-10-26T19:46:45.878144Z","steps":["trace[267743935] 'process raft request'  (duration: 779.715016ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:46:45.878226Z","caller":"traceutil/trace.go:171","msg":"trace[2004758754] transaction","detail":"{read_only:false; response_revision:14341; number_of_response:1; }","duration":"779.48617ms","start":"2026-10-26T19:46:45.09873Z","end":"2026-10-26T19:46:45.878216Z","steps":["trace[2004758754] 'process raft request'  (duration: 779.368667ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:46:45.878337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:45.098278Z","time spent":"779.968534ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:14265 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-10-26T19:46:45.878341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:45.097821Z","time spent":"780.424006ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:14266 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-10-26T19:46:45.878382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.393108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:46:45.878556Z","caller":"traceutil/trace.go:171","msg":"trace[828642145] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:14341; }","duration":"779.551452ms","start":"2026-10-26T19:46:45.098943Z","end":"2026-10-26T19:46:45.878495Z","steps":["trace[828642145] 'agreement among raft nodes before linearized reading'  (duration: 779.374888ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:46:45.87858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:45.098687Z","time spent":"779.562833ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:14264 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-10-26T19:46:45.878611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:45.098933Z","time spent":"779.662295ms","remote":"127.0.0.1:52174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "}
{"level":"info","ts":"2026-10-26T19:46:46.254212Z","caller":"traceutil/trace.go:171","msg":"trace[1968068720] transaction","detail":"{read_only:false; response_revision:14342; number_of_response:1; }","duration":"1.028934554s","start":"2026-10-26T19:46:45.225251Z","end":"2026-10-26T19:46:46.254186Z","steps":["trace[1968068720] 'process raft request'  (duration: 948.585322ms)","trace[1968068720] 'compare'  (duration: 79.783727ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:46:46.254233Z","caller":"traceutil/trace.go:171","msg":"trace[88128213] transaction","detail":"{read_only:false; response_revision:14343; number_of_response:1; }","duration":"1.004067211s","start":"2026-10-26T19:46:45.25013Z","end":"2026-10-26T19:46:46.254197Z","steps":["trace[88128213] 'process raft request'  (duration: 1.003878366s)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:46:46.254326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:45.225224Z","time spent":"1.029040386s","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:14268 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-10-26T19:46:46.254376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:45.250102Z","time spent":"1.004195895s","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:14270 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-10-26T19:46:46.370363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.224622ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3113290786271002740 > lease_revoke:<id:2b34a179a62dfd86>","response":"size:29"}
{"level":"info","ts":"2026-10-26T19:46:46.370453Z","caller":"traceutil/trace.go:171","msg":"trace[866070244] linearizableReadLoop","detail":"{readStateIndex:14839; appliedIndex:14836; }","duration":"492.255086ms","start":"2026-10-26T19:46:45.878184Z","end":"2026-10-26T19:46:46.370439Z","steps":["trace[866070244] 'read index received'  (duration: 295.746614ms)","trace[866070244] 'applied index is now lower than readState.Index'  (duration: 196.507052ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:46:46.370538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.213745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-26T19:46:46.370578Z","caller":"traceutil/trace.go:171","msg":"trace[839679496] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/; range_end:/registry/ceph.rook.io/cephclusters0; response_count:0; response_revision:14343; }","duration":"644.298046ms","start":"2026-10-26T19:46:45.72627Z","end":"2026-10-26T19:46:46.370568Z","steps":["trace[839679496] 'agreement among raft nodes before linearized reading'  (duration: 644.213564ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:46:46.37059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.51763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7f31e57e-23da-489b-9401-d8e4fbbab8f3\" ","response":"range_response_count:1 size:3637"}
{"level":"warn","ts":"2026-10-26T19:46:46.370605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:45.726249Z","time spent":"644.348898ms","remote":"127.0.0.1:59274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":31,"request content":"key:\"/registry/ceph.rook.io/cephclusters/\" range_end:\"/registry/ceph.rook.io/cephclusters0\" count_only:true "}
{"level":"info","ts":"2026-10-26T19:46:46.370609Z","caller":"traceutil/trace.go:171","msg":"trace[1014197413] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7f31e57e-23da-489b-9401-d8e4fbbab8f3; range_end:; response_count:1; response_revision:14343; }","duration":"749.574042ms","start":"2026-10-26T19:46:45.621027Z","end":"2026-10-26T19:46:46.370602Z","steps":["trace[1014197413] 'agreement among raft nodes before linearized reading'  (duration: 749.476069ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:46:46.370629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:45.621008Z","time spent":"749.616433ms","remote":"127.0.0.1:52158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3661,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7f31e57e-23da-489b-9401-d8e4fbbab8f3\" "}
{"level":"warn","ts":"2026-10-26T19:46:46.370772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.103086048s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-10-26T19:46:46.370799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.15458457s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-hm9gb\" ","response":"range_response_count:1 size:20806"}
{"level":"info","ts":"2026-10-26T19:46:46.370865Z","caller":"traceutil/trace.go:171","msg":"trace[762144258] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14343; }","duration":"1.103210211s","start":"2026-10-26T19:46:45.267631Z","end":"2026-10-26T19:46:46.370841Z","steps":["trace[762144258] 'agreement among raft nodes before linearized reading'  (duration: 1.102940854s)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:46:46.370871Z","caller":"traceutil/trace.go:171","msg":"trace[441566969] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-hm9gb; range_end:; response_count:1; response_revision:14343; }","duration":"1.154693732s","start":"2026-10-26T19:46:45.216157Z","end":"2026-10-26T19:46:46.370851Z","steps":["trace[441566969] 'agreement among raft nodes before linearized reading'  (duration: 1.154474417s)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:46:46.370822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.565265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-10-26T19:46:46.370901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.141750323s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-10-26T19:46:46.370932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:45.267614Z","time spent":"1.103301753s","remote":"127.0.0.1:52234","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-10-26T19:46:46.370932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:45.216139Z","time spent":"1.154779525s","remote":"127.0.0.1:52158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20830,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-hm9gb\" "}
{"level":"info","ts":"2026-10-26T19:46:46.370954Z","caller":"traceutil/trace.go:171","msg":"trace[1927357823] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:14343; }","duration":"977.75015ms","start":"2026-10-26T19:46:45.393178Z","end":"2026-10-26T19:46:46.370929Z","steps":["trace[1927357823] 'agreement among raft nodes before linearized reading'  (duration: 977.518133ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:46:46.370963Z","caller":"traceutil/trace.go:171","msg":"trace[1989554960] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14343; }","duration":"1.141851956s","start":"2026-10-26T19:46:45.229093Z","end":"2026-10-26T19:46:46.370945Z","steps":["trace[1989554960] 'agreement among raft nodes before linearized reading'  (duration: 1.141582739s)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:46:46.37098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.548964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-10-26T19:46:46.371009Z","caller":"traceutil/trace.go:171","msg":"trace[1424699257] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14343; }","duration":"829.619986ms","start":"2026-10-26T19:46:45.541381Z","end":"2026-10-26T19:46:46.371001Z","steps":["trace[1424699257] 'agreement among raft nodes before linearized reading'  (duration: 829.444111ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:46:46.371135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.053535119s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-26T19:46:46.371196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.63289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-nova\" ","response":"range_response_count:1 size:3295"}
{"level":"info","ts":"2026-10-26T19:46:46.371277Z","caller":"traceutil/trace.go:171","msg":"trace[662828435] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-nova; range_end:; response_count:1; response_revision:14343; }","duration":"622.754143ms","start":"2026-10-26T19:46:45.748498Z","end":"2026-10-26T19:46:46.371253Z","steps":["trace[662828435] 'agreement among raft nodes before linearized reading'  (duration: 622.554068ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:46:46.371327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:45.748476Z","time spent":"622.840886ms","remote":"127.0.0.1:60724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":3319,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-nova\" "}
{"level":"warn","ts":"2026-10-26T19:46:46.371007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:45.393163Z","time spent":"977.830662ms","remote":"127.0.0.1:43646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "}
{"level":"info","ts":"2026-10-26T19:46:46.371259Z","caller":"traceutil/trace.go:171","msg":"trace[1992837892] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14343; }","duration":"1.053691762s","start":"2026-10-26T19:46:45.317549Z","end":"2026-10-26T19:46:46.371241Z","steps":["trace[1992837892] 'agreement among raft nodes before linearized reading'  (duration: 1.053373593s)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:46:46.371174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:45.54136Z","time spent":"829.805951ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-10-26T19:46:46.371462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:45.317526Z","time spent":"1.053915698s","remote":"127.0.0.1:51958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-10-26T19:46:46.371012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:45.229073Z","time spent":"1.141925187s","remote":"127.0.0.1:52234","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":"warn","ts":"2026-10-26T19:46:46.37108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.429238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7f31e57e-23da-489b-9401-d8e4fbbab8f3\" ","response":"range_response_count:1 size:3637"}
{"level":"info","ts":"2026-10-26T19:46:46.371738Z","caller":"traceutil/trace.go:171","msg":"trace[891869526] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7f31e57e-23da-489b-9401-d8e4fbbab8f3; range_end:; response_count:1; response_revision:14343; }","duration":"575.084145ms","start":"2026-10-26T19:46:45.796607Z","end":"2026-10-26T19:46:46.371691Z","steps":["trace[891869526] 'agreement among raft nodes before linearized reading'  (duration: 574.319505ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:46:46.371783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:45.796587Z","time spent":"575.181698ms","remote":"127.0.0.1:52158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3661,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7f31e57e-23da-489b-9401-d8e4fbbab8f3\" "}
{"level":"warn","ts":"2026-10-26T19:46:46.371074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.396612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12432"}
{"level":"info","ts":"2026-10-26T19:46:46.371867Z","caller":"traceutil/trace.go:171","msg":"trace[1865954241] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14343; }","duration":"489.266245ms","start":"2026-10-26T19:46:45.882584Z","end":"2026-10-26T19:46:46.37185Z","steps":["trace[1865954241] 'agreement among raft nodes before linearized reading'  (duration: 488.211517ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:46:46.370951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.047467694s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-2ztw2\" ","response":"range_response_count:1 size:6531"}
{"level":"warn","ts":"2026-10-26T19:46:46.371916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:45.882567Z","time spent":"489.336117ms","remote":"127.0.0.1:52158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12456,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-10-26T19:46:46.37193Z","caller":"traceutil/trace.go:171","msg":"trace[1821398094] range","detail":"{range_begin:/registry/pods/openstack/keepalived-2ztw2; range_end:; response_count:1; response_revision:14343; }","duration":"1.048512322s","start":"2026-10-26T19:46:45.323401Z","end":"2026-10-26T19:46:46.371913Z","steps":["trace[1821398094] 'agreement among raft nodes before linearized reading'  (duration: 1.047343961s)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:46:46.371979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:46:45.323371Z","time spent":"1.048591564s","remote":"127.0.0.1:52158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6555,"request content":"key:\"/registry/pods/openstack/keepalived-2ztw2\" "}
{"level":"warn","ts":"2026-10-26T19:48:01.672864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.225646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"}
{"level":"info","ts":"2026-10-26T19:48:01.672936Z","caller":"traceutil/trace.go:171","msg":"trace[24481743] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15100; }","duration":"145.338249ms","start":"2026-10-26T19:48:01.527582Z","end":"2026-10-26T19:48:01.67292Z","steps":["trace[24481743] 'range keys from in-memory index tree'  (duration: 145.091312ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:48:01.672981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.942401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-26T19:48:01.672971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.579853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:48:01.673018Z","caller":"traceutil/trace.go:171","msg":"trace[1026485984] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:15100; }","duration":"137.004403ms","start":"2026-10-26T19:48:01.536002Z","end":"2026-10-26T19:48:01.673007Z","steps":["trace[1026485984] 'count revisions from in-memory index tree'  (duration: 136.8848ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:48:01.673055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.7753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"info","ts":"2026-10-26T19:48:01.673086Z","caller":"traceutil/trace.go:171","msg":"trace[1238139716] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15100; }","duration":"146.719596ms","start":"2026-10-26T19:48:01.526334Z","end":"2026-10-26T19:48:01.673054Z","steps":["trace[1238139716] 'range keys from in-memory index tree'  (duration: 146.51412ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:48:01.673104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.193377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:48:01.673121Z","caller":"traceutil/trace.go:171","msg":"trace[2031601985] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15100; }","duration":"145.887504ms","start":"2026-10-26T19:48:01.527215Z","end":"2026-10-26T19:48:01.673103Z","steps":["trace[2031601985] 'range keys from in-memory index tree'  (duration: 145.655057ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:48:01.673148Z","caller":"traceutil/trace.go:171","msg":"trace[1250113779] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15100; }","duration":"151.265959ms","start":"2026-10-26T19:48:01.521871Z","end":"2026-10-26T19:48:01.673137Z","steps":["trace[1250113779] 'range keys from in-memory index tree'  (duration: 151.122715ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:48:01.673218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.699944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"}
{"level":"info","ts":"2026-10-26T19:48:01.673242Z","caller":"traceutil/trace.go:171","msg":"trace[798418138] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15100; }","duration":"150.766816ms","start":"2026-10-26T19:48:01.522469Z","end":"2026-10-26T19:48:01.673236Z","steps":["trace[798418138] 'range keys from in-memory index tree'  (duration: 150.57406ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:48:01.673271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.880451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"info","ts":"2026-10-26T19:48:01.673308Z","caller":"traceutil/trace.go:171","msg":"trace[1096590893] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15100; }","duration":"132.933063ms","start":"2026-10-26T19:48:01.540366Z","end":"2026-10-26T19:48:01.6733Z","steps":["trace[1096590893] 'range keys from in-memory index tree'  (duration: 132.778719ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:48:03.183758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.546048ms","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-10-26T19:48:03.183864Z","caller":"traceutil/trace.go:171","msg":"trace[1133072234] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:15108; }","duration":"120.737123ms","start":"2026-10-26T19:48:03.063103Z","end":"2026-10-26T19:48:03.18384Z","steps":["trace[1133072234] 'range keys from in-memory index tree'  (duration: 120.453405ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:48:03.184283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.142654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-wp7lz\" ","response":"range_response_count:1 size:22132"}
{"level":"info","ts":"2026-10-26T19:48:03.184312Z","caller":"traceutil/trace.go:171","msg":"trace[1284003817] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-wp7lz; range_end:; response_count:1; response_revision:15108; }","duration":"158.219415ms","start":"2026-10-26T19:48:03.026083Z","end":"2026-10-26T19:48:03.184302Z","steps":["trace[1284003817] 'range keys from in-memory index tree'  (duration: 157.958338ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:48:16.63513Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12727}
{"level":"info","ts":"2026-10-26T19:48:16.71749Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12727,"took":"78.876562ms","hash":4004465837,"current-db-size-bytes":56811520,"current-db-size":"57 MB","current-db-size-in-use-bytes":30560256,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-26T19:48:16.717597Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4004465837,"revision":12727,"compact-revision":10546}
{"level":"info","ts":"2026-10-26T19:53:16.648611Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15176}
{"level":"info","ts":"2026-10-26T19:53:16.821885Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15176,"took":"170.966651ms","hash":4063432580,"current-db-size-bytes":56811520,"current-db-size":"57 MB","current-db-size-in-use-bytes":31391744,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-26T19:53:16.821933Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4063432580,"revision":15176,"compact-revision":12727}
{"level":"info","ts":"2026-10-26T19:54:25.2842Z","caller":"traceutil/trace.go:171","msg":"trace[1903299013] transaction","detail":"{read_only:false; response_revision:17860; number_of_response:1; }","duration":"164.565148ms","start":"2026-10-26T19:54:25.119612Z","end":"2026-10-26T19:54:25.284177Z","steps":["trace[1903299013] 'process raft request'  (duration: 164.417674ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:54:25.322608Z","caller":"traceutil/trace.go:171","msg":"trace[55252362] linearizableReadLoop","detail":"{readStateIndex:18470; appliedIndex:18468; }","duration":"114.393812ms","start":"2026-10-26T19:54:25.208187Z","end":"2026-10-26T19:54:25.322581Z","steps":["trace[55252362] 'read index received'  (duration: 75.875821ms)","trace[55252362] 'applied index is now lower than readState.Index'  (duration: 38.516321ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:54:25.322685Z","caller":"traceutil/trace.go:171","msg":"trace[24373303] transaction","detail":"{read_only:false; response_revision:17861; number_of_response:1; }","duration":"164.749933ms","start":"2026-10-26T19:54:25.157892Z","end":"2026-10-26T19:54:25.322642Z","steps":["trace[24373303] 'process raft request'  (duration: 164.523777ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:54:25.322851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.640139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-10-26T19:54:25.322886Z","caller":"traceutil/trace.go:171","msg":"trace[1932911726] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17861; }","duration":"114.743641ms","start":"2026-10-26T19:54:25.20813Z","end":"2026-10-26T19:54:25.322874Z","steps":["trace[1932911726] 'agreement among raft nodes before linearized reading'  (duration: 114.581867ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:54:26.266247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.192795ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3113290786271016589 > lease_revoke:<id:2b34a179a62e353c>","response":"size:30"}
{"level":"info","ts":"2026-10-26T19:54:26.266454Z","caller":"traceutil/trace.go:171","msg":"trace[1250082590] linearizableReadLoop","detail":"{readStateIndex:18473; appliedIndex:18472; }","duration":"697.156373ms","start":"2026-10-26T19:54:25.569272Z","end":"2026-10-26T19:54:26.266428Z","steps":["trace[1250082590] 'read index received'  (duration: 262.776353ms)","trace[1250082590] 'applied index is now lower than readState.Index'  (duration: 434.37714ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:54:26.266705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.826597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-26T19:54:26.266828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.769584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1987"}
{"level":"info","ts":"2026-10-26T19:54:26.266959Z","caller":"traceutil/trace.go:171","msg":"trace[95350245] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:17863; }","duration":"100.97974ms","start":"2026-10-26T19:54:26.165957Z","end":"2026-10-26T19:54:26.266936Z","steps":["trace[95350245] 'agreement among raft nodes before linearized reading'  (duration: 100.746513ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:54:26.266844Z","caller":"traceutil/trace.go:171","msg":"trace[103223997] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:17863; }","duration":"372.997351ms","start":"2026-10-26T19:54:25.893811Z","end":"2026-10-26T19:54:26.266808Z","steps":["trace[103223997] 'agreement among raft nodes before linearized reading'  (duration: 372.817506ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:54:26.267164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:54:25.893794Z","time spent":"373.32867ms","remote":"127.0.0.1:52366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":30,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "}
{"level":"warn","ts":"2026-10-26T19:54:26.266705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.427331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-hm9gb\" ","response":"range_response_count:1 size:20909"}
{"level":"info","ts":"2026-10-26T19:54:26.267288Z","caller":"traceutil/trace.go:171","msg":"trace[705191589] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-hm9gb; range_end:; response_count:1; response_revision:17863; }","duration":"698.039807ms","start":"2026-10-26T19:54:25.569217Z","end":"2026-10-26T19:54:26.267257Z","steps":["trace[705191589] 'agreement among raft nodes before linearized reading'  (duration: 697.371299ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:54:26.267349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:54:25.569194Z","time spent":"698.135569ms","remote":"127.0.0.1:52158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20933,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-hm9gb\" "}
{"level":"warn","ts":"2026-10-26T19:54:26.574444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.973394ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3113290786271016594 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/ingress/openstack/network\" mod_revision:17498 > success:<request_put:<key:\"/registry/ingress/openstack/network\" value_size:794 >> failure:<request_range:<key:\"/registry/ingress/openstack/network\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-26T19:54:26.574789Z","caller":"traceutil/trace.go:171","msg":"trace[822495557] transaction","detail":"{read_only:false; response_revision:17865; number_of_response:1; }","duration":"299.731602ms","start":"2026-10-26T19:54:26.275015Z","end":"2026-10-26T19:54:26.574747Z","steps":["trace[822495557] 'process raft request'  (duration: 158.921376ms)","trace[822495557] 'compare'  (duration: 139.768658ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:54:26.574709Z","caller":"traceutil/trace.go:171","msg":"trace[1679928830] transaction","detail":"{read_only:false; response_revision:17866; number_of_response:1; }","duration":"294.695856ms","start":"2026-10-26T19:54:26.27999Z","end":"2026-10-26T19:54:26.574686Z","steps":["trace[1679928830] 'process raft request'  (duration: 294.594873ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:54:26.633825Z","caller":"traceutil/trace.go:171","msg":"trace[1210906304] transaction","detail":"{read_only:false; response_revision:17867; number_of_response:1; }","duration":"337.7532ms","start":"2026-10-26T19:54:26.296039Z","end":"2026-10-26T19:54:26.633792Z","steps":["trace[1210906304] 'process raft request'  (duration: 337.529124ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:54:26.633985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:54:26.296018Z","time spent":"337.875113ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:17853 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-26T19:54:26.633986Z","caller":"traceutil/trace.go:171","msg":"trace[708454255] linearizableReadLoop","detail":"{readStateIndex:18477; appliedIndex:18474; }","duration":"326.503265ms","start":"2026-10-26T19:54:26.307194Z","end":"2026-10-26T19:54:26.633697Z","steps":["trace[708454255] 'read index received'  (duration: 126.652313ms)","trace[708454255] 'applied index is now lower than readState.Index'  (duration: 199.850082ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:54:26.634078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.877765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-wp7lz\" ","response":"range_response_count:1 size:22133"}
{"level":"info","ts":"2026-10-26T19:54:26.634147Z","caller":"traceutil/trace.go:171","msg":"trace[387279345] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-wp7lz; range_end:; response_count:1; response_revision:17867; }","duration":"326.988219ms","start":"2026-10-26T19:54:26.307141Z","end":"2026-10-26T19:54:26.634129Z","steps":["trace[387279345] 'agreement among raft nodes before linearized reading'  (duration: 326.759293ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:54:26.634213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:54:26.307121Z","time spent":"327.081131ms","remote":"127.0.0.1:52158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22157,"request content":"key:\"/registry/pods/openstack/nova-compute-default-wp7lz\" "}
{"level":"warn","ts":"2026-10-26T19:54:26.634258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.355498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T19:54:26.634288Z","caller":"traceutil/trace.go:171","msg":"trace[998500483] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17867; }","duration":"317.42341ms","start":"2026-10-26T19:54:26.316857Z","end":"2026-10-26T19:54:26.63428Z","steps":["trace[998500483] 'agreement among raft nodes before linearized reading'  (duration: 317.373169ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:54:26.634324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:54:26.316836Z","time spent":"317.482241ms","remote":"127.0.0.1:51958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-10-26T19:54:35.119714Z","caller":"traceutil/trace.go:171","msg":"trace[22852546] transaction","detail":"{read_only:false; response_revision:17995; number_of_response:1; }","duration":"112.859571ms","start":"2026-10-26T19:54:35.006829Z","end":"2026-10-26T19:54:35.119688Z","steps":["trace[22852546] 'process raft request'  (duration: 112.731537ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:54:35.19728Z","caller":"traceutil/trace.go:171","msg":"trace[508687116] transaction","detail":"{read_only:false; response_revision:17996; number_of_response:1; }","duration":"149.323866ms","start":"2026-10-26T19:54:35.047925Z","end":"2026-10-26T19:54:35.197249Z","steps":["trace[508687116] 'process raft request'  (duration: 148.541955ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:57:19.627685Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a656331365382b34","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-26T19:57:19.634059Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-10-26T19:57:19.63421Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-10-26T19:58:16.663378Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17398}
{"level":"info","ts":"2026-10-26T19:58:16.76814Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17398,"took":"102.10028ms","hash":2960518810,"current-db-size-bytes":56811520,"current-db-size":"57 MB","current-db-size-in-use-bytes":33763328,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-10-26T19:58:16.768237Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2960518810,"revision":17398,"compact-revision":15176}
{"level":"warn","ts":"2026-10-26T20:00:01.674524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.61598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T20:00:01.674659Z","caller":"traceutil/trace.go:171","msg":"trace[1707232742] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:20505; }","duration":"101.842606ms","start":"2026-10-26T20:00:01.572792Z","end":"2026-10-26T20:00:01.674635Z","steps":["trace[1707232742] 'count revisions from in-memory index tree'  (duration: 101.499027ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:00:08.783678Z","caller":"traceutil/trace.go:171","msg":"trace[186656538] linearizableReadLoop","detail":"{readStateIndex:21257; appliedIndex:21256; }","duration":"119.492794ms","start":"2026-10-26T20:00:08.664166Z","end":"2026-10-26T20:00:08.783658Z","steps":["trace[186656538] 'read index received'  (duration: 119.399001ms)","trace[186656538] 'applied index is now lower than readState.Index'  (duration: 92.802µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T20:00:08.783762Z","caller":"traceutil/trace.go:171","msg":"trace[1255010759] transaction","detail":"{read_only:false; response_revision:20557; number_of_response:1; }","duration":"126.870973ms","start":"2026-10-26T20:00:08.656884Z","end":"2026-10-26T20:00:08.783755Z","steps":["trace[1255010759] 'process raft request'  (duration: 126.643577ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:00:08.783984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.805153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-10-26T20:00:08.78401Z","caller":"traceutil/trace.go:171","msg":"trace[1638465072] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20557; }","duration":"119.908995ms","start":"2026-10-26T20:00:08.664095Z","end":"2026-10-26T20:00:08.784004Z","steps":["trace[1638465072] 'agreement among raft nodes before linearized reading'  (duration: 119.789482ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:00:08.800799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.358029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-10-26T20:00:08.80088Z","caller":"traceutil/trace.go:171","msg":"trace[1057633460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20558; }","duration":"133.464992ms","start":"2026-10-26T20:00:08.667398Z","end":"2026-10-26T20:00:08.800863Z","steps":["trace[1057633460] 'agreement among raft nodes before linearized reading'  (duration: 133.245356ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:00:08.800916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.108906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T20:00:08.800975Z","caller":"traceutil/trace.go:171","msg":"trace[668051261] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:20558; }","duration":"132.195668ms","start":"2026-10-26T20:00:08.668765Z","end":"2026-10-26T20:00:08.800961Z","steps":["trace[668051261] 'agreement among raft nodes before linearized reading'  (duration: 132.102205ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:00:09.162428Z","caller":"traceutil/trace.go:171","msg":"trace[1000175338] transaction","detail":"{read_only:false; response_revision:20559; number_of_response:1; }","duration":"370.480896ms","start":"2026-10-26T20:00:08.791927Z","end":"2026-10-26T20:00:09.162408Z","steps":["trace[1000175338] 'process raft request'  (duration: 370.365153ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:00:09.16255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:00:08.791908Z","time spent":"370.579778ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:20547 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-10-26T20:00:09.367996Z","caller":"traceutil/trace.go:171","msg":"trace[888213875] transaction","detail":"{read_only:false; response_revision:20560; number_of_response:1; }","duration":"562.974445ms","start":"2026-10-26T20:00:08.804986Z","end":"2026-10-26T20:00:09.36796Z","steps":["trace[888213875] 'process raft request'  (duration: 562.456041ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:00:09.368379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:00:08.80497Z","time spent":"563.100139ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:20548 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-10-26T20:00:09.374905Z","caller":"traceutil/trace.go:171","msg":"trace[713179893] transaction","detail":"{read_only:false; response_revision:20561; number_of_response:1; }","duration":"410.009336ms","start":"2026-10-26T20:00:08.964873Z","end":"2026-10-26T20:00:09.374882Z","steps":["trace[713179893] 'process raft request'  (duration: 403.13313ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:00:09.374949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.454635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T20:00:09.374992Z","caller":"traceutil/trace.go:171","msg":"trace[1088892413] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:20561; }","duration":"486.543817ms","start":"2026-10-26T20:00:08.888435Z","end":"2026-10-26T20:00:09.374978Z","steps":["trace[1088892413] 'agreement among raft nodes before linearized reading'  (duration: 486.456155ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:00:09.375007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:00:08.964846Z","time spent":"410.115229ms","remote":"127.0.0.1:44800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418561,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" mod_revision:20166 > success:<request_put:<key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" value_size:418493 >> failure:<request_range:<key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" > >"}
{"level":"warn","ts":"2026-10-26T20:00:09.375018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:00:08.888417Z","time spent":"486.593138ms","remote":"127.0.0.1:40950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "}
{"level":"info","ts":"2026-10-26T20:00:09.375237Z","caller":"traceutil/trace.go:171","msg":"trace[1996890275] linearizableReadLoop","detail":"{readStateIndex:21260; appliedIndex:21258; }","duration":"485.844229ms","start":"2026-10-26T20:00:08.888475Z","end":"2026-10-26T20:00:09.374319Z","steps":["trace[1996890275] 'read index received'  (duration: 273.763099ms)","trace[1996890275] 'applied index is now lower than readState.Index'  (duration: 212.08038ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T20:00:09.375361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.1526ms","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-10-26T20:00:09.375383Z","caller":"traceutil/trace.go:171","msg":"trace[133707930] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20561; }","duration":"257.212371ms","start":"2026-10-26T20:00:09.118165Z","end":"2026-10-26T20:00:09.375377Z","steps":["trace[133707930] 'agreement among raft nodes before linearized reading'  (duration: 257.129649ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:00:09.37559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.330393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-10-26T20:00:09.375653Z","caller":"traceutil/trace.go:171","msg":"trace[1679202314] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20561; }","duration":"152.419165ms","start":"2026-10-26T20:00:09.223224Z","end":"2026-10-26T20:00:09.375644Z","steps":["trace[1679202314] 'agreement among raft nodes before linearized reading'  (duration: 152.305692ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:00:09.375676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.489094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12433"}
{"level":"info","ts":"2026-10-26T20:00:09.375708Z","caller":"traceutil/trace.go:171","msg":"trace[192836960] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:20561; }","duration":"129.549826ms","start":"2026-10-26T20:00:09.246149Z","end":"2026-10-26T20:00:09.375699Z","steps":["trace[192836960] 'agreement among raft nodes before linearized reading'  (duration: 129.443053ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:00:09.375826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.050578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-10-26T20:00:09.375902Z","caller":"traceutil/trace.go:171","msg":"trace[1596472580] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20561; }","duration":"134.15048ms","start":"2026-10-26T20:00:09.241718Z","end":"2026-10-26T20:00:09.375869Z","steps":["trace[1596472580] 'agreement among raft nodes before linearized reading'  (duration: 133.959925ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:00:09.675902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.125288ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3113290786271024370 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:20551 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-26T20:00:09.676023Z","caller":"traceutil/trace.go:171","msg":"trace[1833631685] transaction","detail":"{read_only:false; response_revision:20562; number_of_response:1; }","duration":"297.568951ms","start":"2026-10-26T20:00:09.378432Z","end":"2026-10-26T20:00:09.676001Z","steps":["trace[1833631685] 'process raft request'  (duration: 105.242888ms)","trace[1833631685] 'compare'  (duration: 191.84471ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T20:00:09.689757Z","caller":"traceutil/trace.go:171","msg":"trace[397061642] linearizableReadLoop","detail":"{readStateIndex:21264; appliedIndex:21261; }","duration":"309.559417ms","start":"2026-10-26T20:00:09.380174Z","end":"2026-10-26T20:00:09.689733Z","steps":["trace[397061642] 'read index received'  (duration: 103.49331ms)","trace[397061642] 'applied index is now lower than readState.Index'  (duration: 206.065237ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T20:00:09.690116Z","caller":"traceutil/trace.go:171","msg":"trace[2136432191] transaction","detail":"{read_only:false; response_revision:20563; number_of_response:1; }","duration":"311.079158ms","start":"2026-10-26T20:00:09.379022Z","end":"2026-10-26T20:00:09.690101Z","steps":["trace[2136432191] 'process raft request'  (duration: 310.511142ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:00:09.690231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:00:09.379013Z","time spent":"311.135499ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:20554 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-26T20:00:09.6904Z","caller":"traceutil/trace.go:171","msg":"trace[2118569207] transaction","detail":"{read_only:false; response_revision:20564; number_of_response:1; }","duration":"311.327424ms","start":"2026-10-26T20:00:09.379062Z","end":"2026-10-26T20:00:09.690389Z","steps":["trace[2118569207] 'process raft request'  (duration: 310.628635ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:00:09.690448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:00:09.379056Z","time spent":"311.365065ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:20553 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-10-26T20:00:09.690717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.534043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12433"}
{"level":"info","ts":"2026-10-26T20:00:09.690775Z","caller":"traceutil/trace.go:171","msg":"trace[184811581] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:20564; }","duration":"310.604365ms","start":"2026-10-26T20:00:09.380156Z","end":"2026-10-26T20:00:09.69076Z","steps":["trace[184811581] 'agreement among raft nodes before linearized reading'  (duration: 310.41238ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:00:09.690813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:00:09.380149Z","time spent":"310.653626ms","remote":"127.0.0.1:52158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12457,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-10-26T20:00:10.099117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.923757ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3113290786271024377 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:20555 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-26T20:00:10.099332Z","caller":"traceutil/trace.go:171","msg":"trace[2099399569] transaction","detail":"{read_only:false; response_revision:20565; number_of_response:1; }","duration":"387.851446ms","start":"2026-10-26T20:00:09.711394Z","end":"2026-10-26T20:00:10.099245Z","steps":["trace[2099399569] 'process raft request'  (duration: 172.700613ms)","trace[2099399569] 'compare'  (duration: 210.516617ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T20:00:10.099313Z","caller":"traceutil/trace.go:171","msg":"trace[241141013] linearizableReadLoop","detail":"{readStateIndex:21265; appliedIndex:21264; }","duration":"341.872862ms","start":"2026-10-26T20:00:09.757418Z","end":"2026-10-26T20:00:10.09929Z","steps":["trace[241141013] 'read index received'  (duration: 126.569676ms)","trace[241141013] 'applied index is now lower than readState.Index'  (duration: 215.301116ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T20:00:10.099601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:00:09.711375Z","time spent":"388.082063ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:20555 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-10-26T20:00:10.099571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.141199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T20:00:10.099731Z","caller":"traceutil/trace.go:171","msg":"trace[1353516010] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:20565; }","duration":"342.309284ms","start":"2026-10-26T20:00:09.757389Z","end":"2026-10-26T20:00:10.099699Z","steps":["trace[1353516010] 'agreement among raft nodes before linearized reading'  (duration: 342.054177ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:00:10.099782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:00:09.757373Z","time spent":"342.390666ms","remote":"127.0.0.1:52442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":30,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"info","ts":"2026-10-26T20:00:10.342058Z","caller":"traceutil/trace.go:171","msg":"trace[1447105980] linearizableReadLoop","detail":"{readStateIndex:21267; appliedIndex:21266; }","duration":"204.288178ms","start":"2026-10-26T20:00:10.137751Z","end":"2026-10-26T20:00:10.34204Z","steps":["trace[1447105980] 'read index received'  (duration: 200.958818ms)","trace[1447105980] 'applied index is now lower than readState.Index'  (duration: 3.32853ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T20:00:10.342383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.623158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:6012"}
{"level":"info","ts":"2026-10-26T20:00:10.342555Z","caller":"traceutil/trace.go:171","msg":"trace[929115452] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:20566; }","duration":"204.839563ms","start":"2026-10-26T20:00:10.137705Z","end":"2026-10-26T20:00:10.342544Z","steps":["trace[929115452] 'agreement among raft nodes before linearized reading'  (duration: 204.521854ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:00:10.342458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.748429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"}
{"level":"info","ts":"2026-10-26T20:00:10.342808Z","caller":"traceutil/trace.go:171","msg":"trace[1331458191] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:20566; }","duration":"199.137289ms","start":"2026-10-26T20:00:10.143659Z","end":"2026-10-26T20:00:10.342796Z","steps":["trace[1331458191] 'agreement among raft nodes before linearized reading'  (duration: 198.667996ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:03:16.677466Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19724}
{"level":"info","ts":"2026-10-26T20:03:16.806495Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19724,"took":"125.081261ms","hash":3183780615,"current-db-size-bytes":56811520,"current-db-size":"57 MB","current-db-size-in-use-bytes":31191040,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-26T20:03:16.80656Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3183780615,"revision":19724,"compact-revision":17398}
{"level":"info","ts":"2026-10-26T20:03:32.96925Z","caller":"traceutil/trace.go:171","msg":"trace[1799617655] transaction","detail":"{read_only:false; response_revision:22212; number_of_response:1; }","duration":"165.895783ms","start":"2026-10-26T20:03:32.803301Z","end":"2026-10-26T20:03:32.969197Z","steps":["trace[1799617655] 'process raft request'  (duration: 165.555454ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:04:14.083367Z","caller":"traceutil/trace.go:171","msg":"trace[756943648] transaction","detail":"{read_only:false; response_revision:23055; number_of_response:1; }","duration":"294.660225ms","start":"2026-10-26T20:04:13.788671Z","end":"2026-10-26T20:04:14.083331Z","steps":["trace[756943648] 'process raft request'  (duration: 294.441799ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:04:14.10902Z","caller":"traceutil/trace.go:171","msg":"trace[871304015] transaction","detail":"{read_only:false; response_revision:23056; number_of_response:1; }","duration":"272.391788ms","start":"2026-10-26T20:04:13.836576Z","end":"2026-10-26T20:04:14.108968Z","steps":["trace[871304015] 'process raft request'  (duration: 272.12748ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:04:14.109422Z","caller":"traceutil/trace.go:171","msg":"trace[576514582] transaction","detail":"{read_only:false; response_revision:23057; number_of_response:1; }","duration":"269.728335ms","start":"2026-10-26T20:04:13.839678Z","end":"2026-10-26T20:04:14.109407Z","steps":["trace[576514582] 'process raft request'  (duration: 269.240891ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:07:10.175642Z","caller":"traceutil/trace.go:171","msg":"trace[1236718544] transaction","detail":"{read_only:false; response_revision:24852; number_of_response:1; }","duration":"180.219668ms","start":"2026-10-26T20:07:09.995403Z","end":"2026-10-26T20:07:10.175622Z","steps":["trace[1236718544] 'process raft request'  (duration: 180.098684ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:07:10.182067Z","caller":"traceutil/trace.go:171","msg":"trace[1209390204] transaction","detail":"{read_only:false; response_revision:24854; number_of_response:1; }","duration":"130.022687ms","start":"2026-10-26T20:07:10.052022Z","end":"2026-10-26T20:07:10.182045Z","steps":["trace[1209390204] 'process raft request'  (duration: 129.952485ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:07:10.182374Z","caller":"traceutil/trace.go:171","msg":"trace[1957341849] transaction","detail":"{read_only:false; response_revision:24853; number_of_response:1; }","duration":"131.487297ms","start":"2026-10-26T20:07:10.050879Z","end":"2026-10-26T20:07:10.182366Z","steps":["trace[1957341849] 'process raft request'  (duration: 130.998744ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:07:10.182577Z","caller":"traceutil/trace.go:171","msg":"trace[1419393781] transaction","detail":"{read_only:false; response_revision:24855; number_of_response:1; }","duration":"129.309297ms","start":"2026-10-26T20:07:10.053259Z","end":"2026-10-26T20:07:10.182568Z","steps":["trace[1419393781] 'process raft request'  (duration: 128.757262ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:07:10.499372Z","caller":"traceutil/trace.go:171","msg":"trace[1036067438] transaction","detail":"{read_only:false; response_revision:24858; number_of_response:1; }","duration":"126.314876ms","start":"2026-10-26T20:07:10.373023Z","end":"2026-10-26T20:07:10.499338Z","steps":["trace[1036067438] 'process raft request'  (duration: 111.973577ms)","trace[1036067438] 'compare'  (duration: 13.156147ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T20:07:32.859395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.798737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-10-26T20:07:32.85947Z","caller":"traceutil/trace.go:171","msg":"trace[898236005] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25088; }","duration":"238.91297ms","start":"2026-10-26T20:07:32.62054Z","end":"2026-10-26T20:07:32.859453Z","steps":["trace[898236005] 'range keys from in-memory index tree'  (duration: 238.661823ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:07:32.859516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.614448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-10-26T20:07:32.859561Z","caller":"traceutil/trace.go:171","msg":"trace[1538268824] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25088; }","duration":"201.688431ms","start":"2026-10-26T20:07:32.657859Z","end":"2026-10-26T20:07:32.859548Z","steps":["trace[1538268824] 'range keys from in-memory index tree'  (duration: 201.509476ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:07:33.044246Z","caller":"traceutil/trace.go:171","msg":"trace[1770698470] transaction","detail":"{read_only:false; response_revision:25089; number_of_response:1; }","duration":"179.55165ms","start":"2026-10-26T20:07:32.864655Z","end":"2026-10-26T20:07:33.044207Z","steps":["trace[1770698470] 'process raft request'  (duration: 179.432797ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:07:33.414899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.120631ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3113290786271036487 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25076 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-26T20:07:33.415047Z","caller":"traceutil/trace.go:171","msg":"trace[1977345527] transaction","detail":"{read_only:false; response_revision:25090; number_of_response:1; }","duration":"550.298116ms","start":"2026-10-26T20:07:32.864735Z","end":"2026-10-26T20:07:33.415033Z","steps":["trace[1977345527] 'process raft request'  (duration: 357.97309ms)","trace[1977345527] 'compare'  (duration: 192.011338ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T20:07:33.415084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:07:32.864673Z","time spent":"550.392998ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25076 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-26T20:07:33.415303Z","caller":"traceutil/trace.go:171","msg":"trace[1245316343] transaction","detail":"{read_only:false; response_revision:25091; number_of_response:1; }","duration":"522.599574ms","start":"2026-10-26T20:07:32.892696Z","end":"2026-10-26T20:07:33.415296Z","steps":["trace[1245316343] 'process raft request'  (duration: 522.296656ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:07:33.41534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:07:32.892676Z","time spent":"522.646066ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:25077 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-10-26T20:07:33.415361Z","caller":"traceutil/trace.go:171","msg":"trace[367733685] transaction","detail":"{read_only:false; response_revision:25093; number_of_response:1; }","duration":"230.696147ms","start":"2026-10-26T20:07:33.184644Z","end":"2026-10-26T20:07:33.41534Z","steps":["trace[367733685] 'process raft request'  (duration: 230.655996ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:07:33.415456Z","caller":"traceutil/trace.go:171","msg":"trace[537138184] transaction","detail":"{read_only:false; response_revision:25092; number_of_response:1; }","duration":"421.853232ms","start":"2026-10-26T20:07:32.993596Z","end":"2026-10-26T20:07:33.41545Z","steps":["trace[537138184] 'process raft request'  (duration: 421.599286ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:07:33.415489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:07:32.993576Z","time spent":"421.897033ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:25078 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-10-26T20:07:33.41553Z","caller":"traceutil/trace.go:171","msg":"trace[425417035] linearizableReadLoop","detail":"{readStateIndex:25919; appliedIndex:25917; }","duration":"549.700979ms","start":"2026-10-26T20:07:32.865825Z","end":"2026-10-26T20:07:33.415526Z","steps":["trace[425417035] 'read index received'  (duration: 178.309366ms)","trace[425417035] 'applied index is now lower than readState.Index'  (duration: 371.391013ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T20:07:33.415667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.798529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-26T20:07:33.415685Z","caller":"traceutil/trace.go:171","msg":"trace[436547440] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:25093; }","duration":"529.848771ms","start":"2026-10-26T20:07:32.88583Z","end":"2026-10-26T20:07:33.415678Z","steps":["trace[436547440] 'agreement among raft nodes before linearized reading'  (duration: 529.748928ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:07:33.415698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:07:32.885813Z","time spent":"529.881762ms","remote":"127.0.0.1:52328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":98,"response size":32,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "}
{"level":"warn","ts":"2026-10-26T20:07:33.415726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.884984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11835"}
{"level":"info","ts":"2026-10-26T20:07:33.415792Z","caller":"traceutil/trace.go:171","msg":"trace[560867132] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25093; }","duration":"549.982427ms","start":"2026-10-26T20:07:32.865794Z","end":"2026-10-26T20:07:33.415777Z","steps":["trace[560867132] 'agreement among raft nodes before linearized reading'  (duration: 549.756871ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:07:33.415819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:07:32.865787Z","time spent":"550.027358ms","remote":"127.0.0.1:52442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":11859,"request content":"key:\"/registry/deployments/openstack/glance-api\" "}
{"level":"warn","ts":"2026-10-26T20:07:33.415843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.099887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-10-26T20:07:33.415865Z","caller":"traceutil/trace.go:171","msg":"trace[1200516222] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25093; }","duration":"162.158849ms","start":"2026-10-26T20:07:33.2537Z","end":"2026-10-26T20:07:33.415859Z","steps":["trace[1200516222] 'agreement among raft nodes before linearized reading'  (duration: 162.082416ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:07:33.415967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.350493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-26T20:07:33.415988Z","caller":"traceutil/trace.go:171","msg":"trace[1368628734] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:25093; }","duration":"454.399475ms","start":"2026-10-26T20:07:32.961581Z","end":"2026-10-26T20:07:33.41598Z","steps":["trace[1368628734] 'agreement among raft nodes before linearized reading'  (duration: 454.363144ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:07:33.416001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:07:32.961564Z","time spent":"454.433085ms","remote":"127.0.0.1:60724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":9,"response size":32,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true "}
{"level":"info","ts":"2026-10-26T20:07:33.793674Z","caller":"traceutil/trace.go:171","msg":"trace[1554040429] linearizableReadLoop","detail":"{readStateIndex:25923; appliedIndex:25922; }","duration":"259.635361ms","start":"2026-10-26T20:07:33.534018Z","end":"2026-10-26T20:07:33.793654Z","steps":["trace[1554040429] 'read index received'  (duration: 249.480686ms)","trace[1554040429] 'applied index is now lower than readState.Index'  (duration: 10.153905ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T20:07:33.793759Z","caller":"traceutil/trace.go:171","msg":"trace[1603284611] transaction","detail":"{read_only:false; response_revision:25094; number_of_response:1; }","duration":"374.044074ms","start":"2026-10-26T20:07:33.419696Z","end":"2026-10-26T20:07:33.79374Z","steps":["trace[1603284611] 'process raft request'  (duration: 363.855987ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:07:33.793848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.806417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-10-26T20:07:33.793862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:07:33.419673Z","time spent":"374.132557ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:25080 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-10-26T20:07:33.793887Z","caller":"traceutil/trace.go:171","msg":"trace[1486493435] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:25094; }","duration":"259.887678ms","start":"2026-10-26T20:07:33.533987Z","end":"2026-10-26T20:07:33.793875Z","steps":["trace[1486493435] 'agreement among raft nodes before linearized reading'  (duration: 259.770995ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:08:08.995264Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000066aa.wal"}
{"level":"info","ts":"2026-10-26T20:08:16.695581Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22043}
{"level":"info","ts":"2026-10-26T20:08:16.828613Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22043,"took":"129.854182ms","hash":3627463878,"current-db-size-bytes":57655296,"current-db-size":"58 MB","current-db-size-in-use-bytes":45715456,"current-db-size-in-use":"46 MB"}
{"level":"info","ts":"2026-10-26T20:08:16.828725Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3627463878,"revision":22043,"compact-revision":19724}
{"level":"info","ts":"2026-10-26T20:08:29.813847Z","caller":"traceutil/trace.go:171","msg":"trace[592885243] transaction","detail":"{read_only:false; response_revision:25608; number_of_response:1; }","duration":"145.795755ms","start":"2026-10-26T20:08:29.668038Z","end":"2026-10-26T20:08:29.813833Z","steps":["trace[592885243] 'process raft request'  (duration: 145.678821ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:08:29.816374Z","caller":"traceutil/trace.go:171","msg":"trace[1627073288] transaction","detail":"{read_only:false; response_revision:25609; number_of_response:1; }","duration":"146.825462ms","start":"2026-10-26T20:08:29.669535Z","end":"2026-10-26T20:08:29.81636Z","steps":["trace[1627073288] 'process raft request'  (duration: 145.911567ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:08:29.816525Z","caller":"traceutil/trace.go:171","msg":"trace[477672634] transaction","detail":"{read_only:false; response_revision:25610; number_of_response:1; }","duration":"118.958157ms","start":"2026-10-26T20:08:29.697556Z","end":"2026-10-26T20:08:29.816514Z","steps":["trace[477672634] 'process raft request'  (duration: 118.002611ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:08:35.51103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.993907ms","expected-duration":"100ms","prefix":"","request":"header:<ID:3113290786271037858 > lease_revoke:<id:2b34a179a62e8891>","response":"size:30"}
{"level":"info","ts":"2026-10-26T20:08:35.511158Z","caller":"traceutil/trace.go:171","msg":"trace[97861588] linearizableReadLoop","detail":"{readStateIndex:26492; appliedIndex:26491; }","duration":"136.347178ms","start":"2026-10-26T20:08:35.374792Z","end":"2026-10-26T20:08:35.511139Z","steps":["trace[97861588] 'read index received'  (duration: 27.651µs)","trace[97861588] 'applied index is now lower than readState.Index'  (duration: 136.317687ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T20:08:35.511378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.567644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-10-26T20:08:35.511414Z","caller":"traceutil/trace.go:171","msg":"trace[1425664191] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25649; }","duration":"136.638956ms","start":"2026-10-26T20:08:35.374764Z","end":"2026-10-26T20:08:35.511403Z","steps":["trace[1425664191] 'agreement among raft nodes before linearized reading'  (duration: 136.42795ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:08:35.834436Z","caller":"traceutil/trace.go:171","msg":"trace[1511538686] transaction","detail":"{read_only:false; response_revision:25650; number_of_response:1; }","duration":"318.738445ms","start":"2026-10-26T20:08:35.515679Z","end":"2026-10-26T20:08:35.834418Z","steps":["trace[1511538686] 'process raft request'  (duration: 318.327874ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:08:35.834551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:08:35.515655Z","time spent":"318.831418ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:25636 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-10-26T20:08:36.111633Z","caller":"traceutil/trace.go:171","msg":"trace[757999615] linearizableReadLoop","detail":"{readStateIndex:26497; appliedIndex:26496; }","duration":"221.393605ms","start":"2026-10-26T20:08:35.890216Z","end":"2026-10-26T20:08:36.111609Z","steps":["trace[757999615] 'read index received'  (duration: 154.613644ms)","trace[757999615] 'applied index is now lower than readState.Index'  (duration: 66.779151ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T20:08:36.111757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.521168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T20:08:36.111725Z","caller":"traceutil/trace.go:171","msg":"trace[1254978775] transaction","detail":"{read_only:false; response_revision:25654; number_of_response:1; }","duration":"249.344803ms","start":"2026-10-26T20:08:35.862337Z","end":"2026-10-26T20:08:36.111682Z","steps":["trace[1254978775] 'process raft request'  (duration: 182.536341ms)","trace[1254978775] 'compare'  (duration: 66.641118ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T20:08:36.111794Z","caller":"traceutil/trace.go:171","msg":"trace[949991755] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:25654; }","duration":"221.57104ms","start":"2026-10-26T20:08:35.890208Z","end":"2026-10-26T20:08:36.111779Z","steps":["trace[949991755] 'agreement among raft nodes before linearized reading'  (duration: 221.498418ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:08:36.382645Z","caller":"traceutil/trace.go:171","msg":"trace[1304894375] linearizableReadLoop","detail":"{readStateIndex:26498; appliedIndex:26497; }","duration":"270.942039ms","start":"2026-10-26T20:08:36.111683Z","end":"2026-10-26T20:08:36.382625Z","steps":["trace[1304894375] 'read index received'  (duration: 270.019174ms)","trace[1304894375] 'applied index is now lower than readState.Index'  (duration: 922.065µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T20:08:36.382673Z","caller":"traceutil/trace.go:171","msg":"trace[1286748491] transaction","detail":"{read_only:false; response_revision:25655; number_of_response:1; }","duration":"319.781204ms","start":"2026-10-26T20:08:36.062877Z","end":"2026-10-26T20:08:36.382658Z","steps":["trace[1286748491] 'process raft request'  (duration: 319.031103ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:08:36.382767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:08:36.062856Z","time spent":"319.848165ms","remote":"127.0.0.1:52234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:25583 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-10-26T20:08:36.382778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.096956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/routerinterfaces/\" range_end:\"/registry/openstack.k-orc.cloud/routerinterfaces0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T20:08:36.382807Z","caller":"traceutil/trace.go:171","msg":"trace[889695083] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/routerinterfaces/; range_end:/registry/openstack.k-orc.cloud/routerinterfaces0; response_count:0; response_revision:25655; }","duration":"371.166997ms","start":"2026-10-26T20:08:36.01163Z","end":"2026-10-26T20:08:36.382797Z","steps":["trace[889695083] 'agreement among raft nodes before linearized reading'  (duration: 371.089645ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:08:36.38283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:08:36.011612Z","time spent":"371.210708ms","remote":"127.0.0.1:58948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/routerinterfaces/\" range_end:\"/registry/openstack.k-orc.cloud/routerinterfaces0\" count_only:true "}
{"level":"warn","ts":"2026-10-26T20:08:36.382978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.535716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-10-26T20:08:36.383013Z","caller":"traceutil/trace.go:171","msg":"trace[1296890539] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25655; }","duration":"236.601287ms","start":"2026-10-26T20:08:36.146403Z","end":"2026-10-26T20:08:36.383004Z","steps":["trace[1296890539] 'agreement among raft nodes before linearized reading'  (duration: 236.479264ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:08:36.383032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.144808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"warn","ts":"2026-10-26T20:08:36.382938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.917415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1854"}
{"level":"warn","ts":"2026-10-26T20:08:36.383085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.391682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-26T20:08:36.383087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.756201ms","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-10-26T20:08:36.383109Z","caller":"traceutil/trace.go:171","msg":"trace[315600221] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:25655; }","duration":"215.461134ms","start":"2026-10-26T20:08:36.16764Z","end":"2026-10-26T20:08:36.383101Z","steps":["trace[315600221] 'agreement among raft nodes before linearized reading'  (duration: 215.421113ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:08:36.383118Z","caller":"traceutil/trace.go:171","msg":"trace[1742481377] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25655; }","duration":"184.816083ms","start":"2026-10-26T20:08:36.198295Z","end":"2026-10-26T20:08:36.383111Z","steps":["trace[1742481377] 'agreement among raft nodes before linearized reading'  (duration: 184.745981ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:08:36.383169Z","caller":"traceutil/trace.go:171","msg":"trace[801126030] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25655; }","duration":"352.114531ms","start":"2026-10-26T20:08:36.030983Z","end":"2026-10-26T20:08:36.383098Z","steps":["trace[801126030] 'agreement among raft nodes before linearized reading'  (duration: 351.681859ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:08:36.383247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:08:36.030924Z","time spent":"352.306015ms","remote":"127.0.0.1:52128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1878,"request content":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-10-26T20:08:36.383064Z","caller":"traceutil/trace.go:171","msg":"trace[1542705496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25655; }","duration":"183.210849ms","start":"2026-10-26T20:08:36.199845Z","end":"2026-10-26T20:08:36.383056Z","steps":["trace[1542705496] 'agreement among raft nodes before linearized reading'  (duration: 183.124507ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:08:36.383483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.411275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12433"}
{"level":"info","ts":"2026-10-26T20:08:36.383555Z","caller":"traceutil/trace.go:171","msg":"trace[918127138] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25655; }","duration":"287.525869ms","start":"2026-10-26T20:08:36.096016Z","end":"2026-10-26T20:08:36.383542Z","steps":["trace[918127138] 'agreement among raft nodes before linearized reading'  (duration: 286.619894ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:12:24.921424Z","caller":"traceutil/trace.go:171","msg":"trace[502766270] transaction","detail":"{read_only:false; response_revision:27872; number_of_response:1; }","duration":"194.881133ms","start":"2026-10-26T20:12:24.726525Z","end":"2026-10-26T20:12:24.921406Z","steps":["trace[502766270] 'process raft request'  (duration: 194.765869ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:12:24.93666Z","caller":"traceutil/trace.go:171","msg":"trace[411283244] linearizableReadLoop","detail":"{readStateIndex:28771; appliedIndex:28768; }","duration":"152.623293ms","start":"2026-10-26T20:12:24.78402Z","end":"2026-10-26T20:12:24.936644Z","steps":["trace[411283244] 'read index received'  (duration: 137.318147ms)","trace[411283244] 'applied index is now lower than readState.Index'  (duration: 15.304286ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T20:12:24.93711Z","caller":"traceutil/trace.go:171","msg":"trace[2078976897] transaction","detail":"{read_only:false; response_revision:27873; number_of_response:1; }","duration":"172.74699ms","start":"2026-10-26T20:12:24.764349Z","end":"2026-10-26T20:12:24.937095Z","steps":["trace[2078976897] 'process raft request'  (duration: 172.091483ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:12:24.937292Z","caller":"traceutil/trace.go:171","msg":"trace[1317032502] transaction","detail":"{read_only:false; response_revision:27874; number_of_response:1; }","duration":"157.963378ms","start":"2026-10-26T20:12:24.779319Z","end":"2026-10-26T20:12:24.937282Z","steps":["trace[1317032502] 'process raft request'  (duration: 157.28423ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:12:24.93754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.432885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T20:12:24.937584Z","caller":"traceutil/trace.go:171","msg":"trace[384757786] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:27874; }","duration":"153.586989ms","start":"2026-10-26T20:12:24.783986Z","end":"2026-10-26T20:12:24.937573Z","steps":["trace[384757786] 'agreement among raft nodes before linearized reading'  (duration: 153.436435ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:12:24.945703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.523761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T20:12:24.946002Z","caller":"traceutil/trace.go:171","msg":"trace[1236451644] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:27875; }","duration":"130.930393ms","start":"2026-10-26T20:12:24.815047Z","end":"2026-10-26T20:12:24.945977Z","steps":["trace[1236451644] 'agreement among raft nodes before linearized reading'  (duration: 130.400808ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:13:16.704874Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25517}
{"level":"info","ts":"2026-10-26T20:13:16.896586Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25517,"took":"188.366666ms","hash":826008800,"current-db-size-bytes":60567552,"current-db-size":"61 MB","current-db-size-in-use-bytes":36331520,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-10-26T20:13:16.896649Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":826008800,"revision":25517,"compact-revision":22043}
{"level":"info","ts":"2026-10-26T20:14:50.498253Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a656331365382b34","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-26T20:14:50.504428Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-10-26T20:14:50.504523Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-10-26T20:15:42.855597Z","caller":"traceutil/trace.go:171","msg":"trace[1637162345] transaction","detail":"{read_only:false; response_revision:29487; number_of_response:1; }","duration":"113.72106ms","start":"2026-10-26T20:15:42.741848Z","end":"2026-10-26T20:15:42.855569Z","steps":["trace[1637162345] 'process raft request'  (duration: 113.524654ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:18:16.712507Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28370}
{"level":"info","ts":"2026-10-26T20:18:16.85825Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28370,"took":"142.721751ms","hash":1183555456,"current-db-size-bytes":60567552,"current-db-size":"61 MB","current-db-size-in-use-bytes":31797248,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-26T20:18:16.858308Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1183555456,"revision":28370,"compact-revision":25517}
{"level":"info","ts":"2026-10-26T20:23:16.721766Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30605}
{"level":"info","ts":"2026-10-26T20:23:16.846988Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30605,"took":"121.580124ms","hash":3540244774,"current-db-size-bytes":60567552,"current-db-size":"61 MB","current-db-size-in-use-bytes":32530432,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-26T20:23:16.847073Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3540244774,"revision":30605,"compact-revision":28370}
{"level":"info","ts":"2026-10-26T20:28:16.748436Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32864}
{"level":"info","ts":"2026-10-26T20:28:16.966667Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32864,"took":"214.437528ms","hash":2401378804,"current-db-size-bytes":60567552,"current-db-size":"61 MB","current-db-size-in-use-bytes":31117312,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-26T20:28:16.966738Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2401378804,"revision":32864,"compact-revision":30605}
{"level":"info","ts":"2026-10-26T20:33:16.754001Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35093}
{"level":"info","ts":"2026-10-26T20:33:16.914979Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35093,"took":"158.140363ms","hash":553852300,"current-db-size-bytes":61419520,"current-db-size":"61 MB","current-db-size-in-use-bytes":31936512,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-26T20:33:16.915046Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":553852300,"revision":35093,"compact-revision":32864}
{"level":"info","ts":"2026-10-26T20:36:17.316927Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a656331365382b34","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-26T20:36:17.324212Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-10-26T20:36:17.324462Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-10-26T20:38:16.759924Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37388}
{"level":"info","ts":"2026-10-26T20:38:16.883186Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37388,"took":"119.603618ms","hash":65921662,"current-db-size-bytes":62689280,"current-db-size":"63 MB","current-db-size-in-use-bytes":32391168,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-26T20:38:16.883248Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":65921662,"revision":37388,"compact-revision":35093}