{"level":"warn","ts":"2026-09-09T01:08:45.625664Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-09T01:08:45.62582Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.179: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.179:2380","--initial-cluster=instance=https://162.253.55.179:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.179:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.179:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-09-09T01:08:45.625959Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-09T01:08:45.625983Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.179:2380"]}
{"level":"info","ts":"2026-09-09T01:08:45.626017Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-09-09T01:08:45.627279Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.179:2379"]}
{"level":"info","ts":"2026-09-09T01:08:45.627447Z","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.179:2380"],"listen-peer-urls":["https://162.253.55.179:2380"],"advertise-client-urls":["https://162.253.55.179:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.179:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.179:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-09-09T01:08:45.631744Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.833185ms"}
{"level":"info","ts":"2026-09-09T01:08:45.641118Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"68b29b9453c9d66d","cluster-id":"f39bc50358d1a417"}
{"level":"info","ts":"2026-09-09T01:08:45.641239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d switched to configuration voters=()"}
{"level":"info","ts":"2026-09-09T01:08:45.641276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d became follower at term 0"}
{"level":"info","ts":"2026-09-09T01:08:45.641299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 68b29b9453c9d66d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-09T01:08:45.641311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d became follower at term 1"}
{"level":"info","ts":"2026-09-09T01:08:45.641362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d switched to configuration voters=(7544263387162203757)"}
{"level":"warn","ts":"2026-09-09T01:08:45.648535Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-09T01:08:45.652818Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-09T01:08:45.656418Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-09-09T01:08:45.659611Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"68b29b9453c9d66d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-09T01:08:45.659897Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"68b29b9453c9d66d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-09T01:08:45.660131Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-09-09T01:08:45.660302Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-09-09T01:08:45.660327Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-09-09T01:08:45.661311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d switched to configuration voters=(7544263387162203757)"}
{"level":"info","ts":"2026-09-09T01:08:45.662453Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f39bc50358d1a417","local-member-id":"68b29b9453c9d66d","added-peer-id":"68b29b9453c9d66d","added-peer-peer-urls":["https://162.253.55.179:2380"]}
{"level":"info","ts":"2026-09-09T01:08:45.664265Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-09-09T01:08:45.66446Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"68b29b9453c9d66d","initial-advertise-peer-urls":["https://162.253.55.179:2380"],"listen-peer-urls":["https://162.253.55.179:2380"],"advertise-client-urls":["https://162.253.55.179:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.179:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-09T01:08:45.664493Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-09T01:08:45.664557Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.179:2380"}
{"level":"info","ts":"2026-09-09T01:08:45.664567Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.179:2380"}
{"level":"info","ts":"2026-09-09T01:08:46.042669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d is starting a new election at term 1"}
{"level":"info","ts":"2026-09-09T01:08:46.04276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-09T01:08:46.042813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d received MsgPreVoteResp from 68b29b9453c9d66d at term 1"}
{"level":"info","ts":"2026-09-09T01:08:46.042838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d became candidate at term 2"}
{"level":"info","ts":"2026-09-09T01:08:46.042855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d received MsgVoteResp from 68b29b9453c9d66d at term 2"}
{"level":"info","ts":"2026-09-09T01:08:46.042876Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"68b29b9453c9d66d became leader at term 2"}
{"level":"info","ts":"2026-09-09T01:08:46.0429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 68b29b9453c9d66d elected leader 68b29b9453c9d66d at term 2"}
{"level":"info","ts":"2026-09-09T01:08:46.044381Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-09T01:08:46.04593Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"68b29b9453c9d66d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.179:2379]}","request-path":"/0/members/68b29b9453c9d66d/attributes","cluster-id":"f39bc50358d1a417","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-09T01:08:46.045936Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-09T01:08:46.046017Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-09T01:08:46.04638Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-09T01:08:46.04642Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-09T01:08:46.047187Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f39bc50358d1a417","local-member-id":"68b29b9453c9d66d","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-09T01:08:46.047283Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-09T01:08:46.047314Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-09T01:08:46.049882Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-09-09T01:08:46.050502Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.179:2379"}
{"level":"info","ts":"2026-09-09T01:09:03.81079Z","caller":"traceutil/trace.go:171","msg":"trace[1398445095] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"191.546192ms","start":"2026-09-09T01:09:03.619211Z","end":"2026-09-09T01:09:03.810757Z","steps":["trace[1398445095] 'process raft request'  (duration: 191.377589ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:09:53.00487Z","caller":"traceutil/trace.go:171","msg":"trace[1332326573] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"239.291086ms","start":"2026-09-09T01:09:52.765548Z","end":"2026-09-09T01:09:53.004839Z","steps":["trace[1332326573] 'process raft request'  (duration: 239.137062ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:09:53.057528Z","caller":"traceutil/trace.go:171","msg":"trace[1524048372] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"139.176129ms","start":"2026-09-09T01:09:52.918316Z","end":"2026-09-09T01:09:53.057492Z","steps":["trace[1524048372] 'process raft request'  (duration: 138.701079ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:09:53.057969Z","caller":"traceutil/trace.go:171","msg":"trace[533953751] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"135.360617ms","start":"2026-09-09T01:09:52.922592Z","end":"2026-09-09T01:09:53.057952Z","steps":["trace[533953751] 'process raft request'  (duration: 134.60299ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:09:53.058093Z","caller":"traceutil/trace.go:171","msg":"trace[827016583] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"129.329735ms","start":"2026-09-09T01:09:52.92873Z","end":"2026-09-09T01:09:53.058059Z","steps":["trace[827016583] 'process raft request'  (duration: 128.962638ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:09:53.058268Z","caller":"traceutil/trace.go:171","msg":"trace[440676649] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"116.089317ms","start":"2026-09-09T01:09:52.942165Z","end":"2026-09-09T01:09:53.058254Z","steps":["trace[440676649] 'process raft request'  (duration: 115.815491ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:09:53.058351Z","caller":"traceutil/trace.go:171","msg":"trace[700897915] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"129.539721ms","start":"2026-09-09T01:09:52.928803Z","end":"2026-09-09T01:09:53.058342Z","steps":["trace[700897915] 'process raft request'  (duration: 129.02853ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:09:53.058448Z","caller":"traceutil/trace.go:171","msg":"trace[1470877974] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"115.190076ms","start":"2026-09-09T01:09:52.943248Z","end":"2026-09-09T01:09:53.058438Z","steps":["trace[1470877974] 'process raft request'  (duration: 114.94381ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:09:53.058517Z","caller":"traceutil/trace.go:171","msg":"trace[120823632] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"115.37551ms","start":"2026-09-09T01:09:52.943133Z","end":"2026-09-09T01:09:53.058508Z","steps":["trace[120823632] 'process raft request'  (duration: 114.90737ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:09:53.058656Z","caller":"traceutil/trace.go:171","msg":"trace[949938788] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"113.5399ms","start":"2026-09-09T01:09:52.945108Z","end":"2026-09-09T01:09:53.058648Z","steps":["trace[949938788] 'process raft request'  (duration: 113.192843ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:09:53.058732Z","caller":"traceutil/trace.go:171","msg":"trace[250012198] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"114.133854ms","start":"2026-09-09T01:09:52.94459Z","end":"2026-09-09T01:09:53.058724Z","steps":["trace[250012198] 'process raft request'  (duration: 113.657813ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:10:00.015751Z","caller":"traceutil/trace.go:171","msg":"trace[1669726880] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"239.642783ms","start":"2026-09-09T01:09:59.776085Z","end":"2026-09-09T01:10:00.015728Z","steps":["trace[1669726880] 'process raft request'  (duration: 239.50759ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:10:00.774538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.788491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.179\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-09-09T01:10:00.774679Z","caller":"traceutil/trace.go:171","msg":"trace[1252871724] range","detail":"{range_begin:/registry/masterleases/162.253.55.179; range_end:; response_count:1; response_revision:702; }","duration":"477.019307ms","start":"2026-09-09T01:10:00.297635Z","end":"2026-09-09T01:10:00.774654Z","steps":["trace[1252871724] 'range keys from in-memory index tree'  (duration: 476.628238ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:10:00.774725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:00.297608Z","time spent":"477.106128ms","remote":"127.0.0.1:49798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.179\" "}
{"level":"warn","ts":"2026-09-09T01:10:00.774729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.922708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"warn","ts":"2026-09-09T01:10:00.774755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.858852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-7dvjn\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-09-09T01:10:00.77485Z","caller":"traceutil/trace.go:171","msg":"trace[1664566837] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:702; }","duration":"549.07532ms","start":"2026-09-09T01:10:00.225729Z","end":"2026-09-09T01:10:00.774804Z","steps":["trace[1664566837] 'range keys from in-memory index tree'  (duration: 548.650991ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:10:00.774875Z","caller":"traceutil/trace.go:171","msg":"trace[2029788545] range","detail":"{range_begin:/registry/pods/kube-system/cilium-7dvjn; range_end:; response_count:1; response_revision:702; }","duration":"596.071106ms","start":"2026-09-09T01:10:00.178778Z","end":"2026-09-09T01:10:00.774849Z","steps":["trace[2029788545] 'range keys from in-memory index tree'  (duration: 595.589236ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:10:00.774897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:00.225703Z","time spent":"549.185103ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-09-09T01:10:00.774927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:00.178754Z","time spent":"596.164209ms","remote":"127.0.0.1:49936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-7dvjn\" "}
{"level":"warn","ts":"2026-09-09T01:10:00.774992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.010201ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T01:10:00.775264Z","caller":"traceutil/trace.go:171","msg":"trace[470734886] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:702; }","duration":"180.289157ms","start":"2026-09-09T01:10:00.594964Z","end":"2026-09-09T01:10:00.775253Z","steps":["trace[470734886] 'range keys from in-memory index tree'  (duration: 180.000731ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:10:00.775229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.61179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-09-09T01:10:00.775329Z","caller":"traceutil/trace.go:171","msg":"trace[103397272] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:702; }","duration":"363.965597ms","start":"2026-09-09T01:10:00.411339Z","end":"2026-09-09T01:10:00.775305Z","steps":["trace[103397272] 'range keys from in-memory index tree'  (duration: 363.357574ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:10:00.775363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:00.411316Z","time spent":"364.039369ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-09-09T01:10:00.775442Z","caller":"traceutil/trace.go:171","msg":"trace[1742108356] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"319.62199ms","start":"2026-09-09T01:10:00.455791Z","end":"2026-09-09T01:10:00.775413Z","steps":["trace[1742108356] 'process raft request'  (duration: 310.260456ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:10:00.775626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.783927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-09-09T01:10:00.775448Z","caller":"traceutil/trace.go:171","msg":"trace[2007360333] linearizableReadLoop","detail":"{readStateIndex:732; appliedIndex:731; }","duration":"234.554181ms","start":"2026-09-09T01:10:00.540856Z","end":"2026-09-09T01:10:00.77541Z","steps":["trace[2007360333] 'read index received'  (duration: 225.000703ms)","trace[2007360333] 'applied index is now lower than readState.Index'  (duration: 9.551948ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:10:00.775673Z","caller":"traceutil/trace.go:171","msg":"trace[1762504704] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:703; }","duration":"234.869909ms","start":"2026-09-09T01:10:00.540791Z","end":"2026-09-09T01:10:00.775661Z","steps":["trace[1762504704] 'agreement among raft nodes before linearized reading'  (duration: 234.693566ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:10:00.776134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:00.455751Z","time spent":"319.763964ms","remote":"127.0.0.1:49854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:701 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036229 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-09-09T01:10:17.695327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.765893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-bkqhm\" ","response":"range_response_count:1 size:3965"}
{"level":"info","ts":"2026-09-09T01:10:17.695388Z","caller":"traceutil/trace.go:171","msg":"trace[1253929334] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-bkqhm; range_end:; response_count:1; response_revision:871; }","duration":"396.868716ms","start":"2026-09-09T01:10:17.298508Z","end":"2026-09-09T01:10:17.695376Z","steps":["trace[1253929334] 'range keys from in-memory index tree'  (duration: 396.624701ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:10:17.695414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:10:17.298489Z","time spent":"396.917267ms","remote":"127.0.0.1:49936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-bkqhm\" "}
{"level":"info","ts":"2026-09-09T01:10:53.079722Z","caller":"traceutil/trace.go:171","msg":"trace[146792246] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"209.147216ms","start":"2026-09-09T01:10:52.870545Z","end":"2026-09-09T01:10:53.079692Z","steps":["trace[146792246] 'process raft request'  (duration: 208.86316ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:11:42.246991Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15451182384129497329,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-09-09T01:11:42.31656Z","caller":"traceutil/trace.go:171","msg":"trace[1003820070] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"570.586459ms","start":"2026-09-09T01:11:41.745929Z","end":"2026-09-09T01:11:42.316516Z","steps":["trace[1003820070] 'process raft request'  (duration: 503.776981ms)","trace[1003820070] 'compare'  (duration: 66.344528ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:11:42.31677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:11:41.745902Z","time spent":"570.751523ms","remote":"127.0.0.1:49936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-33cab117-7be2-445c-976d-98bfa80cf218\" mod_revision:1920 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-33cab117-7be2-445c-976d-98bfa80cf218\" value_size:3632 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-33cab117-7be2-445c-976d-98bfa80cf218\" > >"}
{"level":"warn","ts":"2026-09-09T01:11:42.316852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.152641ms","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-09-09T01:11:42.316923Z","caller":"traceutil/trace.go:171","msg":"trace[1613029965] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1960; }","duration":"570.247873ms","start":"2026-09-09T01:11:41.746656Z","end":"2026-09-09T01:11:42.316904Z","steps":["trace[1613029965] 'agreement among raft nodes before linearized reading'  (duration: 569.968196ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:11:42.316963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:11:41.746645Z","time spent":"570.307735ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-09-09T01:11:42.31656Z","caller":"traceutil/trace.go:171","msg":"trace[118025389] linearizableReadLoop","detail":"{readStateIndex:2039; appliedIndex:2038; }","duration":"569.807723ms","start":"2026-09-09T01:11:41.746682Z","end":"2026-09-09T01:11:42.31649Z","steps":["trace[118025389] 'read index received'  (duration: 503.071866ms)","trace[118025389] 'applied index is now lower than readState.Index'  (duration: 66.733957ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:11:42.317645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.225042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-09T01:11:42.317693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.081801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-33cab117-7be2-445c-976d-98bfa80cf218\" ","response":"range_response_count:1 size:3747"}
{"level":"info","ts":"2026-09-09T01:11:42.31774Z","caller":"traceutil/trace.go:171","msg":"trace[92683179] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-33cab117-7be2-445c-976d-98bfa80cf218; range_end:; response_count:1; response_revision:1960; }","duration":"217.184373ms","start":"2026-09-09T01:11:42.100539Z","end":"2026-09-09T01:11:42.317723Z","steps":["trace[92683179] 'agreement among raft nodes before linearized reading'  (duration: 217.104972ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:11:42.317743Z","caller":"traceutil/trace.go:171","msg":"trace[770853986] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1960; }","duration":"510.394885ms","start":"2026-09-09T01:11:41.807323Z","end":"2026-09-09T01:11:42.317717Z","steps":["trace[770853986] 'agreement among raft nodes before linearized reading'  (duration: 510.225182ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:11:42.317789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:11:41.8073Z","time spent":"510.480068ms","remote":"127.0.0.1:49998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "}
{"level":"warn","ts":"2026-09-09T01:11:42.318157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.819079ms","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-09-09T01:11:42.318261Z","caller":"traceutil/trace.go:171","msg":"trace[980173549] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1960; }","duration":"507.971042ms","start":"2026-09-09T01:11:41.81027Z","end":"2026-09-09T01:11:42.318241Z","steps":["trace[980173549] 'agreement among raft nodes before linearized reading'  (duration: 507.621555ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:11:42.318302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:11:41.810254Z","time spent":"508.038864ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-09-09T01:11:42.604601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.604865ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15451182384129497333 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:1892 > 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:16"}
{"level":"info","ts":"2026-09-09T01:11:42.604781Z","caller":"traceutil/trace.go:171","msg":"trace[1936949904] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"283.023951ms","start":"2026-09-09T01:11:42.321722Z","end":"2026-09-09T01:11:42.604746Z","steps":["trace[1936949904] 'process raft request'  (duration: 106.919275ms)","trace[1936949904] 'compare'  (duration: 175.397131ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:11:42.604843Z","caller":"traceutil/trace.go:171","msg":"trace[739859144] transaction","detail":"{read_only:false; response_revision:1962; number_of_response:1; }","duration":"281.934616ms","start":"2026-09-09T01:11:42.322887Z","end":"2026-09-09T01:11:42.604821Z","steps":["trace[739859144] 'process raft request'  (duration: 281.856625ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:11:42.604881Z","caller":"traceutil/trace.go:171","msg":"trace[1211646092] linearizableReadLoop","detail":"{readStateIndex:2040; appliedIndex:2039; }","duration":"282.218042ms","start":"2026-09-09T01:11:42.32264Z","end":"2026-09-09T01:11:42.604858Z","steps":["trace[1211646092] 'read index received'  (duration: 106.021034ms)","trace[1211646092] 'applied index is now lower than readState.Index'  (duration: 176.193708ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:11:42.605166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.501618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-33cab117-7be2-445c-976d-98bfa80cf218\" ","response":"range_response_count:1 size:3747"}
{"level":"info","ts":"2026-09-09T01:11:42.60522Z","caller":"traceutil/trace.go:171","msg":"trace[1589949275] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-33cab117-7be2-445c-976d-98bfa80cf218; range_end:; response_count:1; response_revision:1962; }","duration":"282.593761ms","start":"2026-09-09T01:11:42.322612Z","end":"2026-09-09T01:11:42.605206Z","steps":["trace[1589949275] 'agreement among raft nodes before linearized reading'  (duration: 282.348545ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:11:42.635299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.828454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-09-09T01:11:42.63537Z","caller":"traceutil/trace.go:171","msg":"trace[1388307252] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1963; }","duration":"292.986207ms","start":"2026-09-09T01:11:42.342366Z","end":"2026-09-09T01:11:42.635353Z","steps":["trace[1388307252] 'agreement among raft nodes before linearized reading'  (duration: 292.767992ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:11:42.635382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.593609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T01:11:42.635429Z","caller":"traceutil/trace.go:171","msg":"trace[516266700] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1963; }","duration":"123.6508ms","start":"2026-09-09T01:11:42.511765Z","end":"2026-09-09T01:11:42.635415Z","steps":["trace[516266700] 'agreement among raft nodes before linearized reading'  (duration: 123.562448ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:11:42.635462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.961691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T01:11:42.635527Z","caller":"traceutil/trace.go:171","msg":"trace[361086443] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1963; }","duration":"202.043512ms","start":"2026-09-09T01:11:42.433467Z","end":"2026-09-09T01:11:42.635511Z","steps":["trace[361086443] 'agreement among raft nodes before linearized reading'  (duration: 201.92336ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:11:42.909431Z","caller":"traceutil/trace.go:171","msg":"trace[71108348] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"214.411982ms","start":"2026-09-09T01:11:42.694986Z","end":"2026-09-09T01:11:42.909398Z","steps":["trace[71108348] 'process raft request'  (duration: 127.588406ms)","trace[71108348] 'compare'  (duration: 86.54187ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:11:51.4649Z","caller":"traceutil/trace.go:171","msg":"trace[742334916] transaction","detail":"{read_only:false; response_revision:2044; number_of_response:1; }","duration":"116.216427ms","start":"2026-09-09T01:11:51.348659Z","end":"2026-09-09T01:11:51.464876Z","steps":["trace[742334916] 'process raft request'  (duration: 116.062484ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:11:55.695813Z","caller":"traceutil/trace.go:171","msg":"trace[890067096] transaction","detail":"{read_only:false; response_revision:2071; number_of_response:1; }","duration":"160.702759ms","start":"2026-09-09T01:11:55.535083Z","end":"2026-09-09T01:11:55.695786Z","steps":["trace[890067096] 'process raft request'  (duration: 125.773337ms)","trace[890067096] 'compare'  (duration: 34.682667ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:12:27.734418Z","caller":"traceutil/trace.go:171","msg":"trace[1382397073] transaction","detail":"{read_only:false; response_revision:2261; number_of_response:1; }","duration":"129.084579ms","start":"2026-09-09T01:12:27.605304Z","end":"2026-09-09T01:12:27.734389Z","steps":["trace[1382397073] 'process raft request'  (duration: 128.909624ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:12:28.224533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.488103ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15451182384129498040 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2251 > 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-09-09T01:12:28.224667Z","caller":"traceutil/trace.go:171","msg":"trace[1308643465] linearizableReadLoop","detail":"{readStateIndex:2354; appliedIndex:2353; }","duration":"395.5103ms","start":"2026-09-09T01:12:27.829135Z","end":"2026-09-09T01:12:28.224646Z","steps":["trace[1308643465] 'read index received'  (duration: 105.822791ms)","trace[1308643465] 'applied index is now lower than readState.Index'  (duration: 289.685849ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:12:28.224765Z","caller":"traceutil/trace.go:171","msg":"trace[500104925] transaction","detail":"{read_only:false; response_revision:2264; number_of_response:1; }","duration":"417.45818ms","start":"2026-09-09T01:12:27.807288Z","end":"2026-09-09T01:12:28.224746Z","steps":["trace[500104925] 'process raft request'  (duration: 127.662689ms)","trace[500104925] 'compare'  (duration: 289.362969ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:12:28.22482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:12:27.807261Z","time spent":"417.531553ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2251 > 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":"warn","ts":"2026-09-09T01:12:28.224853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.714666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T01:12:28.224911Z","caller":"traceutil/trace.go:171","msg":"trace[590739188] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:2264; }","duration":"395.775208ms","start":"2026-09-09T01:12:27.829117Z","end":"2026-09-09T01:12:28.224892Z","steps":["trace[590739188] 'agreement among raft nodes before linearized reading'  (duration: 395.673035ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:12:28.224942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:12:27.829022Z","time spent":"395.911352ms","remote":"127.0.0.1:36568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true "}
{"level":"warn","ts":"2026-09-09T01:12:28.224939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.104157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-09-09T01:12:28.225029Z","caller":"traceutil/trace.go:171","msg":"trace[670392790] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2264; }","duration":"251.241992ms","start":"2026-09-09T01:12:27.97376Z","end":"2026-09-09T01:12:28.225002Z","steps":["trace[670392790] 'agreement among raft nodes before linearized reading'  (duration: 251.033396ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:12:28.224938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.131702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-09-09T01:12:28.225268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.566355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-09-09T01:12:28.225374Z","caller":"traceutil/trace.go:171","msg":"trace[1441136260] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2264; }","duration":"353.465182ms","start":"2026-09-09T01:12:27.871725Z","end":"2026-09-09T01:12:28.22519Z","steps":["trace[1441136260] 'agreement among raft nodes before linearized reading'  (duration: 353.088771ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:12:28.225424Z","caller":"traceutil/trace.go:171","msg":"trace[795719175] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2264; }","duration":"353.75848ms","start":"2026-09-09T01:12:27.871602Z","end":"2026-09-09T01:12:28.22536Z","steps":["trace[795719175] 'agreement among raft nodes before linearized reading'  (duration: 353.284606ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:12:28.225457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:12:27.871694Z","time spent":"353.738239ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-09-09T01:12:28.225482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:12:27.871584Z","time spent":"353.887723ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-09-09T01:12:28.22556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.482049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-09-09T01:12:28.225686Z","caller":"traceutil/trace.go:171","msg":"trace[1209295056] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2264; }","duration":"361.678844ms","start":"2026-09-09T01:12:27.863978Z","end":"2026-09-09T01:12:28.225657Z","steps":["trace[1209295056] 'agreement among raft nodes before linearized reading'  (duration: 360.787119ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:12:28.225739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:12:27.863941Z","time spent":"361.787828ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-09-09T01:12:28.359031Z","caller":"traceutil/trace.go:171","msg":"trace[698725179] transaction","detail":"{read_only:false; response_revision:2266; number_of_response:1; }","duration":"129.158431ms","start":"2026-09-09T01:12:28.229852Z","end":"2026-09-09T01:12:28.35901Z","steps":["trace[698725179] 'process raft request'  (duration: 129.094369ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:12:28.359246Z","caller":"traceutil/trace.go:171","msg":"trace[567203583] transaction","detail":"{read_only:false; response_revision:2267; number_of_response:1; }","duration":"129.382387ms","start":"2026-09-09T01:12:28.229854Z","end":"2026-09-09T01:12:28.359236Z","steps":["trace[567203583] 'process raft request'  (duration: 129.12565ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:12:28.359239Z","caller":"traceutil/trace.go:171","msg":"trace[943408447] transaction","detail":"{read_only:false; response_revision:2265; number_of_response:1; }","duration":"129.350986ms","start":"2026-09-09T01:12:28.229851Z","end":"2026-09-09T01:12:28.359202Z","steps":["trace[943408447] 'process raft request'  (duration: 121.546215ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:14:00.30794Z","caller":"traceutil/trace.go:171","msg":"trace[1302095660] transaction","detail":"{read_only:false; response_revision:2958; number_of_response:1; }","duration":"182.561147ms","start":"2026-09-09T01:14:00.125248Z","end":"2026-09-09T01:14:00.307809Z","steps":["trace[1302095660] 'process raft request'  (duration: 182.337972ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:14:00.312714Z","caller":"traceutil/trace.go:171","msg":"trace[665522942] transaction","detail":"{read_only:false; response_revision:2959; number_of_response:1; }","duration":"103.477495ms","start":"2026-09-09T01:14:00.209211Z","end":"2026-09-09T01:14:00.312689Z","steps":["trace[665522942] 'process raft request'  (duration: 103.239069ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:14:00.520905Z","caller":"traceutil/trace.go:171","msg":"trace[2056938262] transaction","detail":"{read_only:false; response_revision:2960; number_of_response:1; }","duration":"201.068678ms","start":"2026-09-09T01:14:00.319788Z","end":"2026-09-09T01:14:00.520857Z","steps":["trace[2056938262] 'process raft request'  (duration: 145.910657ms)","trace[2056938262] 'compare'  (duration: 54.959366ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:14:00.863383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.254459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T01:14:00.86351Z","caller":"traceutil/trace.go:171","msg":"trace[1910561876] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:2960; }","duration":"185.465774ms","start":"2026-09-09T01:14:00.678019Z","end":"2026-09-09T01:14:00.863485Z","steps":["trace[1910561876] 'count revisions from in-memory index tree'  (duration: 185.186917ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:14:00.86401Z","caller":"traceutil/trace.go:171","msg":"trace[1041969493] transaction","detail":"{read_only:false; response_revision:2961; number_of_response:1; }","duration":"165.199235ms","start":"2026-09-09T01:14:00.698766Z","end":"2026-09-09T01:14:00.863965Z","steps":["trace[1041969493] 'process raft request'  (duration: 136.31278ms)","trace[1041969493] 'compare'  (duration: 28.454045ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:17:13.575649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.918779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-client-secret\" ","response":"range_response_count:1 size:692"}
{"level":"warn","ts":"2026-09-09T01:17:13.575699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.306127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T01:17:13.575796Z","caller":"traceutil/trace.go:171","msg":"trace[844084713] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-client-secret; range_end:; response_count:1; response_revision:4170; }","duration":"465.163275ms","start":"2026-09-09T01:17:13.110601Z","end":"2026-09-09T01:17:13.575764Z","steps":["trace[844084713] 'range keys from in-memory index tree'  (duration: 464.676854ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:17:13.575866Z","caller":"traceutil/trace.go:171","msg":"trace[928479167] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:4170; }","duration":"434.529562ms","start":"2026-09-09T01:17:13.141275Z","end":"2026-09-09T01:17:13.575804Z","steps":["trace[928479167] 'count revisions from in-memory index tree'  (duration: 434.159713ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:17:13.575892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:17:13.110562Z","time spent":"465.311037ms","remote":"127.0.0.1:49854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":715,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-client-secret\" "}
{"level":"warn","ts":"2026-09-09T01:17:13.575931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.298725ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15451182384129502997 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4160 > 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:16"}
{"level":"warn","ts":"2026-09-09T01:17:13.575949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:17:13.141246Z","time spent":"434.685034ms","remote":"127.0.0.1:49966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "}
{"level":"info","ts":"2026-09-09T01:17:13.576041Z","caller":"traceutil/trace.go:171","msg":"trace[703255003] transaction","detail":"{read_only:false; response_revision:4171; number_of_response:1; }","duration":"410.161049ms","start":"2026-09-09T01:17:13.165859Z","end":"2026-09-09T01:17:13.57602Z","steps":["trace[703255003] 'process raft request'  (duration: 200.630419ms)","trace[703255003] 'compare'  (duration: 209.016589ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:17:13.576127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:17:13.165835Z","time spent":"410.249082ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4160 > 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-09-09T01:17:13.576072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.220042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-09-09T01:17:13.576542Z","caller":"traceutil/trace.go:171","msg":"trace[1348575974] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4170; }","duration":"433.732642ms","start":"2026-09-09T01:17:13.142784Z","end":"2026-09-09T01:17:13.576516Z","steps":["trace[1348575974] 'range keys from in-memory index tree'  (duration: 432.963235ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:17:13.57661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:17:13.142772Z","time spent":"433.820855ms","remote":"127.0.0.1:49936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-09-09T01:17:13.608452Z","caller":"traceutil/trace.go:171","msg":"trace[1264430921] transaction","detail":"{read_only:false; response_revision:4172; number_of_response:1; }","duration":"440.588208ms","start":"2026-09-09T01:17:13.167781Z","end":"2026-09-09T01:17:13.60837Z","steps":["trace[1264430921] 'process raft request'  (duration: 440.2354ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:17:13.608684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:17:13.167768Z","time spent":"440.792653ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:4161 > 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-09-09T01:18:44.51378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.016723ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15451182384129505579 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/monitoring/loki-gateway\" mod_revision:0 > success:<request_put:<key:\"/registry/services/endpoints/monitoring/loki-gateway\" value_size:773 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-09-09T01:18:44.513989Z","caller":"traceutil/trace.go:171","msg":"trace[898356663] transaction","detail":"{read_only:false; response_revision:5280; number_of_response:1; }","duration":"141.443989ms","start":"2026-09-09T01:18:44.372527Z","end":"2026-09-09T01:18:44.513971Z","steps":["trace[898356663] 'process raft request'  (duration: 141.365378ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:18:44.514056Z","caller":"traceutil/trace.go:171","msg":"trace[1096993081] transaction","detail":"{read_only:false; response_revision:5279; number_of_response:1; }","duration":"141.656145ms","start":"2026-09-09T01:18:44.372331Z","end":"2026-09-09T01:18:44.513987Z","steps":["trace[1096993081] 'compare'  (duration: 137.838759ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:18:44.529802Z","caller":"traceutil/trace.go:171","msg":"trace[1823983723] linearizableReadLoop","detail":"{readStateIndex:5488; appliedIndex:5487; }","duration":"145.187345ms","start":"2026-09-09T01:18:44.384587Z","end":"2026-09-09T01:18:44.529775Z","steps":["trace[1823983723] 'read index received'  (duration: 145.065742ms)","trace[1823983723] 'applied index is now lower than readState.Index'  (duration: 120.263µs)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:18:44.529905Z","caller":"traceutil/trace.go:171","msg":"trace[442466198] transaction","detail":"{read_only:false; response_revision:5281; number_of_response:1; }","duration":"152.318746ms","start":"2026-09-09T01:18:44.377565Z","end":"2026-09-09T01:18:44.529884Z","steps":["trace[442466198] 'process raft request'  (duration: 152.05529ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:18:44.530045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.433781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-340ace36-b697-4b59-9598-ff7aed193ee6\" ","response":"range_response_count:1 size:2243"}
{"level":"info","ts":"2026-09-09T01:18:44.530094Z","caller":"traceutil/trace.go:171","msg":"trace[1244285038] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-340ace36-b697-4b59-9598-ff7aed193ee6; range_end:; response_count:1; response_revision:5281; }","duration":"145.514483ms","start":"2026-09-09T01:18:44.384562Z","end":"2026-09-09T01:18:44.530076Z","steps":["trace[1244285038] 'agreement among raft nodes before linearized reading'  (duration: 145.318649ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:18:46.261806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.01323ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15451182384129505729 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5244 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-09T01:18:46.262148Z","caller":"traceutil/trace.go:171","msg":"trace[1017937983] linearizableReadLoop","detail":"{readStateIndex:5577; appliedIndex:5576; }","duration":"228.437188ms","start":"2026-09-09T01:18:46.033686Z","end":"2026-09-09T01:18:46.262124Z","steps":["trace[1017937983] 'read index received'  (duration: 67.997018ms)","trace[1017937983] 'applied index is now lower than readState.Index'  (duration: 160.437589ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:18:46.262237Z","caller":"traceutil/trace.go:171","msg":"trace[1937498738] transaction","detail":"{read_only:false; response_revision:5368; number_of_response:1; }","duration":"193.009797ms","start":"2026-09-09T01:18:46.069196Z","end":"2026-09-09T01:18:46.262206Z","steps":["trace[1937498738] 'process raft request'  (duration: 192.843174ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:18:46.26226Z","caller":"traceutil/trace.go:171","msg":"trace[538057107] transaction","detail":"{read_only:false; response_revision:5367; number_of_response:1; }","duration":"298.33985ms","start":"2026-09-09T01:18:45.963878Z","end":"2026-09-09T01:18:46.262217Z","steps":["trace[538057107] 'process raft request'  (duration: 137.789007ms)","trace[538057107] 'compare'  (duration: 159.754295ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:18:46.262329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.634033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-09T01:18:46.262353Z","caller":"traceutil/trace.go:171","msg":"trace[1437374487] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:5370; }","duration":"228.721344ms","start":"2026-09-09T01:18:46.033625Z","end":"2026-09-09T01:18:46.262346Z","steps":["trace[1437374487] 'agreement among raft nodes before linearized reading'  (duration: 228.620862ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:18:46.262277Z","caller":"traceutil/trace.go:171","msg":"trace[219959965] transaction","detail":"{read_only:false; response_revision:5370; number_of_response:1; }","duration":"181.137058ms","start":"2026-09-09T01:18:46.081121Z","end":"2026-09-09T01:18:46.262258Z","steps":["trace[219959965] 'process raft request'  (duration: 181.062216ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:18:46.262684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.755968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-92926e45-e3c3-4597-8cd4-1c4bd4a9f674\" ","response":"range_response_count:1 size:4068"}
{"level":"info","ts":"2026-09-09T01:18:46.262742Z","caller":"traceutil/trace.go:171","msg":"trace[999183393] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-92926e45-e3c3-4597-8cd4-1c4bd4a9f674; range_end:; response_count:1; response_revision:5370; }","duration":"153.85013ms","start":"2026-09-09T01:18:46.108878Z","end":"2026-09-09T01:18:46.262728Z","steps":["trace[999183393] 'agreement among raft nodes before linearized reading'  (duration: 153.649256ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:18:46.26233Z","caller":"traceutil/trace.go:171","msg":"trace[715667205] transaction","detail":"{read_only:false; response_revision:5369; number_of_response:1; }","duration":"187.887241ms","start":"2026-09-09T01:18:46.074429Z","end":"2026-09-09T01:18:46.262316Z","steps":["trace[715667205] 'process raft request'  (duration: 187.696897ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:18:46.263135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.261294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-00b5230a-c49d-4a00-b154-8af528bf9273\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-09-09T01:18:46.263268Z","caller":"traceutil/trace.go:171","msg":"trace[1477709097] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-00b5230a-c49d-4a00-b154-8af528bf9273; range_end:; response_count:1; response_revision:5370; }","duration":"163.444108ms","start":"2026-09-09T01:18:46.099797Z","end":"2026-09-09T01:18:46.263241Z","steps":["trace[1477709097] 'agreement among raft nodes before linearized reading'  (duration: 162.728261ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:18:46.281342Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2880}
{"level":"info","ts":"2026-09-09T01:18:46.366292Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2880,"took":"82.953376ms","hash":250891456,"current-db-size-bytes":53964800,"current-db-size":"54 MB","current-db-size-in-use-bytes":29749248,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-09T01:18:46.366358Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":250891456,"revision":2880,"compact-revision":-1}
{"level":"info","ts":"2026-09-09T01:19:01.659158Z","caller":"traceutil/trace.go:171","msg":"trace[2095286969] linearizableReadLoop","detail":"{readStateIndex:5885; appliedIndex:5883; }","duration":"268.976637ms","start":"2026-09-09T01:19:01.390161Z","end":"2026-09-09T01:19:01.659138Z","steps":["trace[2095286969] 'read index received'  (duration: 268.932135ms)","trace[2095286969] 'applied index is now lower than readState.Index'  (duration: 43.472µs)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:19:01.659174Z","caller":"traceutil/trace.go:171","msg":"trace[1276473125] transaction","detail":"{read_only:false; response_revision:5661; number_of_response:1; }","duration":"281.837057ms","start":"2026-09-09T01:19:01.377293Z","end":"2026-09-09T01:19:01.65913Z","steps":["trace[1276473125] 'process raft request'  (duration: 281.59848ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:19:01.659538Z","caller":"traceutil/trace.go:171","msg":"trace[1955909837] transaction","detail":"{read_only:false; response_revision:5662; number_of_response:1; }","duration":"282.208695ms","start":"2026-09-09T01:19:01.377308Z","end":"2026-09-09T01:19:01.659517Z","steps":["trace[1955909837] 'process raft request'  (duration: 281.725534ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:19:01.659588Z","caller":"traceutil/trace.go:171","msg":"trace[185370712] transaction","detail":"{read_only:false; response_revision:5663; number_of_response:1; }","duration":"281.867668ms","start":"2026-09-09T01:19:01.377713Z","end":"2026-09-09T01:19:01.659581Z","steps":["trace[185370712] 'process raft request'  (duration: 281.365466ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:19:01.659556Z","caller":"traceutil/trace.go:171","msg":"trace[1905641633] transaction","detail":"{read_only:false; response_revision:5664; number_of_response:1; }","duration":"281.232414ms","start":"2026-09-09T01:19:01.37831Z","end":"2026-09-09T01:19:01.659543Z","steps":["trace[1905641633] 'process raft request'  (duration: 280.795983ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:19:01.659806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.347395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-09-09T01:19:01.659855Z","caller":"traceutil/trace.go:171","msg":"trace[371218] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5664; }","duration":"300.420596ms","start":"2026-09-09T01:19:01.359408Z","end":"2026-09-09T01:19:01.659829Z","steps":["trace[371218] 'agreement among raft nodes before linearized reading'  (duration: 300.310534ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:19:01.659879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:19:01.359376Z","time spent":"300.496788ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-09-09T01:19:01.677204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.134348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T01:19:01.677295Z","caller":"traceutil/trace.go:171","msg":"trace[1089089697] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:5665; }","duration":"181.273742ms","start":"2026-09-09T01:19:01.496Z","end":"2026-09-09T01:19:01.677274Z","steps":["trace[1089089697] 'agreement among raft nodes before linearized reading'  (duration: 181.098528ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:19:01.677346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.684006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-09-09T01:19:01.6772Z","caller":"traceutil/trace.go:171","msg":"trace[2014911232] transaction","detail":"{read_only:false; response_revision:5665; number_of_response:1; }","duration":"282.592093ms","start":"2026-09-09T01:19:01.394582Z","end":"2026-09-09T01:19:01.677174Z","steps":["trace[2014911232] 'process raft request'  (duration: 282.397229ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:19:01.677348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.043781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-gx7tm\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-09-09T01:19:01.677379Z","caller":"traceutil/trace.go:171","msg":"trace[1922311795] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5665; }","duration":"164.765728ms","start":"2026-09-09T01:19:01.512603Z","end":"2026-09-09T01:19:01.677369Z","steps":["trace[1922311795] 'agreement among raft nodes before linearized reading'  (duration: 164.651465ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:19:01.677431Z","caller":"traceutil/trace.go:171","msg":"trace[1592634947] range","detail":"{range_begin:/registry/pods/openstack/keepalived-gx7tm; range_end:; response_count:1; response_revision:5665; }","duration":"118.163133ms","start":"2026-09-09T01:19:01.559255Z","end":"2026-09-09T01:19:01.677418Z","steps":["trace[1592634947] 'agreement among raft nodes before linearized reading'  (duration: 117.962058ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:19:09.956809Z","caller":"traceutil/trace.go:171","msg":"trace[1367072023] transaction","detail":"{read_only:false; response_revision:5819; number_of_response:1; }","duration":"127.29014ms","start":"2026-09-09T01:19:09.829471Z","end":"2026-09-09T01:19:09.956761Z","steps":["trace[1367072023] 'process raft request'  (duration: 33.727653ms)","trace[1367072023] 'compare'  (duration: 93.333992ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:19:10.672441Z","caller":"traceutil/trace.go:171","msg":"trace[1401357052] transaction","detail":"{read_only:false; response_revision:5822; number_of_response:1; }","duration":"261.758113ms","start":"2026-09-09T01:19:10.410655Z","end":"2026-09-09T01:19:10.672413Z","steps":["trace[1401357052] 'process raft request'  (duration: 261.496687ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:19:10.672704Z","caller":"traceutil/trace.go:171","msg":"trace[726970268] transaction","detail":"{read_only:false; response_revision:5823; number_of_response:1; }","duration":"237.155397ms","start":"2026-09-09T01:19:10.435527Z","end":"2026-09-09T01:19:10.672682Z","steps":["trace[726970268] 'process raft request'  (duration: 236.808579ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:19:10.672792Z","caller":"traceutil/trace.go:171","msg":"trace[1347501231] transaction","detail":"{read_only:false; response_revision:5824; number_of_response:1; }","duration":"236.695985ms","start":"2026-09-09T01:19:10.436058Z","end":"2026-09-09T01:19:10.672754Z","steps":["trace[1347501231] 'process raft request'  (duration: 236.557092ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:19:10.682126Z","caller":"traceutil/trace.go:171","msg":"trace[1531420485] transaction","detail":"{read_only:false; response_revision:5826; number_of_response:1; }","duration":"220.082129ms","start":"2026-09-09T01:19:10.462015Z","end":"2026-09-09T01:19:10.682097Z","steps":["trace[1531420485] 'process raft request'  (duration: 219.997207ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:19:10.682234Z","caller":"traceutil/trace.go:171","msg":"trace[1856899121] transaction","detail":"{read_only:false; response_revision:5825; number_of_response:1; }","duration":"227.453796ms","start":"2026-09-09T01:19:10.454762Z","end":"2026-09-09T01:19:10.682215Z","steps":["trace[1856899121] 'process raft request'  (duration: 227.110178ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:19:21.894053Z","caller":"traceutil/trace.go:171","msg":"trace[1402717034] transaction","detail":"{read_only:false; response_revision:5999; number_of_response:1; }","duration":"103.508432ms","start":"2026-09-09T01:19:21.790508Z","end":"2026-09-09T01:19:21.894016Z","steps":["trace[1402717034] 'process raft request'  (duration: 103.232385ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:19:21.957161Z","caller":"traceutil/trace.go:171","msg":"trace[136994589] linearizableReadLoop","detail":"{readStateIndex:6228; appliedIndex:6226; }","duration":"160.501051ms","start":"2026-09-09T01:19:21.796625Z","end":"2026-09-09T01:19:21.957126Z","steps":["trace[136994589] 'read index received'  (duration: 97.085317ms)","trace[136994589] 'applied index is now lower than readState.Index'  (duration: 63.414164ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:19:21.957296Z","caller":"traceutil/trace.go:171","msg":"trace[692157122] transaction","detail":"{read_only:false; response_revision:6000; number_of_response:1; }","duration":"163.628872ms","start":"2026-09-09T01:19:21.793619Z","end":"2026-09-09T01:19:21.957248Z","steps":["trace[692157122] 'process raft request'  (duration: 128.16298ms)","trace[692157122] 'compare'  (duration: 35.164445ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:19:21.957474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.831018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-09-09T01:19:21.957565Z","caller":"traceutil/trace.go:171","msg":"trace[898237288] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6000; }","duration":"160.959551ms","start":"2026-09-09T01:19:21.796584Z","end":"2026-09-09T01:19:21.957544Z","steps":["trace[898237288] 'agreement among raft nodes before linearized reading'  (duration: 160.680295ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:19:21.95786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.610713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-gx7tm\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-09-09T01:19:21.957928Z","caller":"traceutil/trace.go:171","msg":"trace[497061731] range","detail":"{range_begin:/registry/pods/openstack/keepalived-gx7tm; range_end:; response_count:1; response_revision:6000; }","duration":"156.718575ms","start":"2026-09-09T01:19:21.801192Z","end":"2026-09-09T01:19:21.957911Z","steps":["trace[497061731] 'agreement among raft nodes before linearized reading'  (duration: 156.373507ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:20:25.287193Z","caller":"traceutil/trace.go:171","msg":"trace[47471612] transaction","detail":"{read_only:false; response_revision:6520; number_of_response:1; }","duration":"190.95544ms","start":"2026-09-09T01:20:25.096208Z","end":"2026-09-09T01:20:25.287164Z","steps":["trace[47471612] 'process raft request'  (duration: 147.701312ms)","trace[47471612] 'compare'  (duration: 43.006123ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:23:46.29051Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5370}
{"level":"info","ts":"2026-09-09T01:23:46.383948Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5370,"took":"91.119981ms","hash":1098040133,"current-db-size-bytes":53964800,"current-db-size":"54 MB","current-db-size-in-use-bytes":28418048,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-09T01:23:46.384019Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1098040133,"revision":5370,"compact-revision":2880}
{"level":"info","ts":"2026-09-09T01:25:24.361366Z","caller":"traceutil/trace.go:171","msg":"trace[626555705] linearizableReadLoop","detail":"{readStateIndex:9025; appliedIndex:9024; }","duration":"118.142543ms","start":"2026-09-09T01:25:24.24317Z","end":"2026-09-09T01:25:24.361313Z","steps":["trace[626555705] 'read index received'  (duration: 89.628258ms)","trace[626555705] 'applied index is now lower than readState.Index'  (duration: 28.513245ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:25:24.361547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.355688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-09T01:25:24.361578Z","caller":"traceutil/trace.go:171","msg":"trace[1512519933] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:8707; }","duration":"118.43431ms","start":"2026-09-09T01:25:24.243133Z","end":"2026-09-09T01:25:24.361567Z","steps":["trace[1512519933] 'agreement among raft nodes before linearized reading'  (duration: 118.319847ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:25:24.361717Z","caller":"traceutil/trace.go:171","msg":"trace[723405154] transaction","detail":"{read_only:false; response_revision:8707; number_of_response:1; }","duration":"127.475223ms","start":"2026-09-09T01:25:24.234212Z","end":"2026-09-09T01:25:24.361687Z","steps":["trace[723405154] 'process raft request'  (duration: 98.624671ms)","trace[723405154] 'compare'  (duration: 28.355351ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:25:24.68365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.5832ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15451182384129514421 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8697 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-09T01:25:24.683903Z","caller":"traceutil/trace.go:171","msg":"trace[1140159785] transaction","detail":"{read_only:false; response_revision:8709; number_of_response:1; }","duration":"407.177582ms","start":"2026-09-09T01:25:24.276706Z","end":"2026-09-09T01:25:24.683884Z","steps":["trace[1140159785] 'process raft request'  (duration: 407.053339ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:25:24.683906Z","caller":"traceutil/trace.go:171","msg":"trace[1869533295] transaction","detail":"{read_only:false; response_revision:8708; number_of_response:1; }","duration":"409.988726ms","start":"2026-09-09T01:25:24.273884Z","end":"2026-09-09T01:25:24.683873Z","steps":["trace[1869533295] 'process raft request'  (duration: 239.087979ms)","trace[1869533295] 'compare'  (duration: 170.266293ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:25:24.683975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:25:24.276695Z","time spent":"407.249833ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8698 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-09-09T01:25:24.684065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:25:24.273863Z","time spent":"410.116898ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8697 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-09-09T01:25:25.31475Z","caller":"traceutil/trace.go:171","msg":"trace[858846954] linearizableReadLoop","detail":"{readStateIndex:9029; appliedIndex:9028; }","duration":"229.82579ms","start":"2026-09-09T01:25:25.0849Z","end":"2026-09-09T01:25:25.314726Z","steps":["trace[858846954] 'read index received'  (duration: 229.554854ms)","trace[858846954] 'applied index is now lower than readState.Index'  (duration: 269.966µs)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:25:25.314831Z","caller":"traceutil/trace.go:171","msg":"trace[833054427] transaction","detail":"{read_only:false; response_revision:8711; number_of_response:1; }","duration":"263.8769ms","start":"2026-09-09T01:25:25.050894Z","end":"2026-09-09T01:25:25.314771Z","steps":["trace[833054427] 'process raft request'  (duration: 263.657615ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:25:25.314965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.052185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-09-09T01:25:25.315002Z","caller":"traceutil/trace.go:171","msg":"trace[688739946] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8711; }","duration":"230.133707ms","start":"2026-09-09T01:25:25.084857Z","end":"2026-09-09T01:25:25.314991Z","steps":["trace[688739946] 'agreement among raft nodes before linearized reading'  (duration: 229.992234ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:25:25.315141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.070284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-09-09T01:25:25.315219Z","caller":"traceutil/trace.go:171","msg":"trace[113523355] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8711; }","duration":"115.166506ms","start":"2026-09-09T01:25:25.200033Z","end":"2026-09-09T01:25:25.3152Z","steps":["trace[113523355] 'agreement among raft nodes before linearized reading'  (duration: 114.89749ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:25:55.051683Z","caller":"traceutil/trace.go:171","msg":"trace[1800583215] transaction","detail":"{read_only:false; response_revision:8924; number_of_response:1; }","duration":"275.125825ms","start":"2026-09-09T01:25:54.776537Z","end":"2026-09-09T01:25:55.051663Z","steps":["trace[1800583215] 'process raft request'  (duration: 275.006222ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:25:55.343342Z","caller":"traceutil/trace.go:171","msg":"trace[975049180] transaction","detail":"{read_only:false; response_revision:8925; number_of_response:1; }","duration":"544.469759ms","start":"2026-09-09T01:25:54.798844Z","end":"2026-09-09T01:25:55.343314Z","steps":["trace[975049180] 'process raft request'  (duration: 538.692508ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:25:55.343646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:25:54.798831Z","time spent":"544.702264ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8913 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-09-09T01:25:55.343472Z","caller":"traceutil/trace.go:171","msg":"trace[1576670556] transaction","detail":"{read_only:false; response_revision:8926; number_of_response:1; }","duration":"528.046828ms","start":"2026-09-09T01:25:54.815412Z","end":"2026-09-09T01:25:55.343459Z","steps":["trace[1576670556] 'process raft request'  (duration: 527.827652ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:25:55.343893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:25:54.815383Z","time spent":"528.438266ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8914 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-09-09T01:26:01.596006Z","caller":"traceutil/trace.go:171","msg":"trace[231198777] transaction","detail":"{read_only:false; response_revision:8958; number_of_response:1; }","duration":"223.718601ms","start":"2026-09-09T01:26:01.37226Z","end":"2026-09-09T01:26:01.595978Z","steps":["trace[231198777] 'process raft request'  (duration: 223.524406ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:26:01.957654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.941966ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15451182384129515245 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8947 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-09T01:26:01.957729Z","caller":"traceutil/trace.go:171","msg":"trace[819575790] linearizableReadLoop","detail":"{readStateIndex:9287; appliedIndex:9286; }","duration":"359.73507ms","start":"2026-09-09T01:26:01.597982Z","end":"2026-09-09T01:26:01.957718Z","steps":["trace[819575790] 'read index received'  (duration: 75.56325ms)","trace[819575790] 'applied index is now lower than readState.Index'  (duration: 284.17089ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:26:01.957877Z","caller":"traceutil/trace.go:171","msg":"trace[981397261] transaction","detail":"{read_only:false; response_revision:8959; number_of_response:1; }","duration":"570.217603ms","start":"2026-09-09T01:26:01.387649Z","end":"2026-09-09T01:26:01.957867Z","steps":["trace[981397261] 'process raft request'  (duration: 286.005012ms)","trace[981397261] 'compare'  (duration: 283.75952ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:26:01.957924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:26:01.387624Z","time spent":"570.277353ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8947 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-09-09T01:26:01.958092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.117329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-09-09T01:26:01.958115Z","caller":"traceutil/trace.go:171","msg":"trace[1477210109] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8959; }","duration":"360.17775ms","start":"2026-09-09T01:26:01.597931Z","end":"2026-09-09T01:26:01.958109Z","steps":["trace[1477210109] 'agreement among raft nodes before linearized reading'  (duration: 360.094898ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:26:01.958136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:26:01.597913Z","time spent":"360.215941ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-09-09T01:26:02.326778Z","caller":"traceutil/trace.go:171","msg":"trace[320208748] linearizableReadLoop","detail":"{readStateIndex:9288; appliedIndex:9287; }","duration":"368.998948ms","start":"2026-09-09T01:26:01.957744Z","end":"2026-09-09T01:26:02.326743Z","steps":["trace[320208748] 'read index received'  (duration: 368.984598ms)","trace[320208748] 'applied index is now lower than readState.Index'  (duration: 12.32µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:26:02.327022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.99599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-09-09T01:26:02.327064Z","caller":"traceutil/trace.go:171","msg":"trace[1508412997] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8960; }","duration":"587.096093ms","start":"2026-09-09T01:26:01.739956Z","end":"2026-09-09T01:26:02.327052Z","steps":["trace[1508412997] 'agreement among raft nodes before linearized reading'  (duration: 586.914339ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:26:02.327097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:26:01.739936Z","time spent":"587.154335ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-09-09T01:26:02.326779Z","caller":"traceutil/trace.go:171","msg":"trace[1210031388] transaction","detail":"{read_only:false; response_revision:8960; number_of_response:1; }","duration":"592.079665ms","start":"2026-09-09T01:26:01.734672Z","end":"2026-09-09T01:26:02.326751Z","steps":["trace[1210031388] 'process raft request'  (duration: 591.885391ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:26:02.327373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.665332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-09-09T01:26:02.327414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:26:01.734639Z","time spent":"592.68463ms","remote":"127.0.0.1:49934","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20168,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:8749 > success:<request_put:<key:\"/registry/minions/instance\" value_size:20132 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-09-09T01:26:02.327471Z","caller":"traceutil/trace.go:171","msg":"trace[834043072] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8960; }","duration":"654.808436ms","start":"2026-09-09T01:26:01.672644Z","end":"2026-09-09T01:26:02.327452Z","steps":["trace[834043072] 'agreement among raft nodes before linearized reading'  (duration: 654.57628ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:26:02.327567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:26:01.672624Z","time spent":"654.929998ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-09-09T01:26:02.500163Z","caller":"traceutil/trace.go:171","msg":"trace[1070021033] transaction","detail":"{read_only:false; response_revision:8961; number_of_response:1; }","duration":"537.665195ms","start":"2026-09-09T01:26:01.962462Z","end":"2026-09-09T01:26:02.500127Z","steps":["trace[1070021033] 'process raft request'  (duration: 462.893134ms)","trace[1070021033] 'compare'  (duration: 74.547556ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:26:02.500292Z","caller":"traceutil/trace.go:171","msg":"trace[1655241253] linearizableReadLoop","detail":"{readStateIndex:9289; appliedIndex:9288; }","duration":"173.400234ms","start":"2026-09-09T01:26:02.32685Z","end":"2026-09-09T01:26:02.500251Z","steps":["trace[1655241253] 'read index received'  (duration: 98.613293ms)","trace[1655241253] 'applied index is now lower than readState.Index'  (duration: 74.780791ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:26:02.500335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:26:01.962438Z","time spent":"537.807188ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:8948 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-09-09T01:26:02.500366Z","caller":"traceutil/trace.go:171","msg":"trace[1482376536] transaction","detail":"{read_only:false; response_revision:8963; number_of_response:1; }","duration":"167.08919ms","start":"2026-09-09T01:26:02.333258Z","end":"2026-09-09T01:26:02.500347Z","steps":["trace[1482376536] 'process raft request'  (duration: 167.025829ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:26:02.500592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.744959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-09-09T01:26:02.500599Z","caller":"traceutil/trace.go:171","msg":"trace[1806508219] transaction","detail":"{read_only:false; response_revision:8962; number_of_response:1; }","duration":"167.344265ms","start":"2026-09-09T01:26:02.333237Z","end":"2026-09-09T01:26:02.500581Z","steps":["trace[1806508219] 'process raft request'  (duration: 166.913496ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:26:02.500635Z","caller":"traceutil/trace.go:171","msg":"trace[813064502] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8963; }","duration":"218.844681ms","start":"2026-09-09T01:26:02.281779Z","end":"2026-09-09T01:26:02.500624Z","steps":["trace[813064502] 'agreement among raft nodes before linearized reading'  (duration: 218.657007ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:26:02.500774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.466104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T01:26:02.500803Z","caller":"traceutil/trace.go:171","msg":"trace[1599273319] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8963; }","duration":"371.546956ms","start":"2026-09-09T01:26:02.129248Z","end":"2026-09-09T01:26:02.500795Z","steps":["trace[1599273319] 'agreement among raft nodes before linearized reading'  (duration: 371.489415ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:26:02.500825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:26:02.12922Z","time spent":"371.598487ms","remote":"127.0.0.1:49748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-09-09T01:26:02.500974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.508424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T01:26:02.501027Z","caller":"traceutil/trace.go:171","msg":"trace[1974390700] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:8963; }","duration":"450.632626ms","start":"2026-09-09T01:26:02.050383Z","end":"2026-09-09T01:26:02.501016Z","steps":["trace[1974390700] 'agreement among raft nodes before linearized reading'  (duration: 450.541074ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:26:02.501052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:26:02.050368Z","time spent":"450.678657ms","remote":"127.0.0.1:50900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}
{"level":"info","ts":"2026-09-09T01:26:09.413411Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000249d.wal"}
{"level":"info","ts":"2026-09-09T01:26:09.413847Z","caller":"traceutil/trace.go:171","msg":"trace[692023720] linearizableReadLoop","detail":"{readStateIndex:9372; appliedIndex:9371; }","duration":"137.618154ms","start":"2026-09-09T01:26:09.276204Z","end":"2026-09-09T01:26:09.413822Z","steps":["trace[692023720] 'read index received'  (duration: 137.352638ms)","trace[692023720] 'applied index is now lower than readState.Index'  (duration: 264.146µs)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:26:09.413932Z","caller":"traceutil/trace.go:171","msg":"trace[2121785529] transaction","detail":"{read_only:false; response_revision:9040; number_of_response:1; }","duration":"139.093706ms","start":"2026-09-09T01:26:09.274802Z","end":"2026-09-09T01:26:09.413896Z","steps":["trace[2121785529] 'process raft request'  (duration: 138.853871ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:26:09.414093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.862129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-wd949\" ","response":"range_response_count:1 size:2803"}
{"level":"info","ts":"2026-09-09T01:26:09.414137Z","caller":"traceutil/trace.go:171","msg":"trace[2122426061] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-wd949; range_end:; response_count:1; response_revision:9040; }","duration":"137.9466ms","start":"2026-09-09T01:26:09.276176Z","end":"2026-09-09T01:26:09.414123Z","steps":["trace[2122426061] 'agreement among raft nodes before linearized reading'  (duration: 137.735146ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:26:10.12608Z","caller":"traceutil/trace.go:171","msg":"trace[824152313] transaction","detail":"{read_only:false; response_revision:9043; number_of_response:1; }","duration":"128.697272ms","start":"2026-09-09T01:26:09.997355Z","end":"2026-09-09T01:26:10.126052Z","steps":["trace[824152313] 'process raft request'  (duration: 128.493888ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:26:10.318838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.746818ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15451182384129515485 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:8924 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:452 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-09T01:26:10.319026Z","caller":"traceutil/trace.go:171","msg":"trace[783566273] transaction","detail":"{read_only:false; response_revision:9046; number_of_response:1; }","duration":"123.490174ms","start":"2026-09-09T01:26:10.195522Z","end":"2026-09-09T01:26:10.319012Z","steps":["trace[783566273] 'process raft request'  (duration: 123.451423ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:26:10.319023Z","caller":"traceutil/trace.go:171","msg":"trace[1225310955] linearizableReadLoop","detail":"{readStateIndex:9376; appliedIndex:9375; }","duration":"185.018246ms","start":"2026-09-09T01:26:10.133981Z","end":"2026-09-09T01:26:10.318999Z","steps":["trace[1225310955] 'read index received'  (duration: 62.057054ms)","trace[1225310955] 'applied index is now lower than readState.Index'  (duration: 122.959832ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:26:10.319173Z","caller":"traceutil/trace.go:171","msg":"trace[355295427] transaction","detail":"{read_only:false; response_revision:9044; number_of_response:1; }","duration":"187.621435ms","start":"2026-09-09T01:26:10.13153Z","end":"2026-09-09T01:26:10.319151Z","steps":["trace[355295427] 'process raft request'  (duration: 64.494559ms)","trace[355295427] 'compare'  (duration: 122.549533ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:26:10.319246Z","caller":"traceutil/trace.go:171","msg":"trace[305666438] transaction","detail":"{read_only:false; response_revision:9045; number_of_response:1; }","duration":"137.391549ms","start":"2026-09-09T01:26:10.181846Z","end":"2026-09-09T01:26:10.319238Z","steps":["trace[305666438] 'process raft request'  (duration: 137.070032ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:26:10.319559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.563778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/ceph.18d382ab7f6f303d\" ","response":"range_response_count:1 size:699"}
{"level":"warn","ts":"2026-09-09T01:26:10.319595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.010496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-wd949\" ","response":"range_response_count:1 size:4650"}
{"level":"info","ts":"2026-09-09T01:26:10.319613Z","caller":"traceutil/trace.go:171","msg":"trace[1068370619] range","detail":"{range_begin:/registry/events/openstack/ceph.18d382ab7f6f303d; range_end:; response_count:1; response_revision:9046; }","duration":"185.644421ms","start":"2026-09-09T01:26:10.133952Z","end":"2026-09-09T01:26:10.319596Z","steps":["trace[1068370619] 'agreement among raft nodes before linearized reading'  (duration: 185.425305ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:26:10.320117Z","caller":"traceutil/trace.go:171","msg":"trace[794385679] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-wd949; range_end:; response_count:1; response_revision:9046; }","duration":"139.099718ms","start":"2026-09-09T01:26:10.180532Z","end":"2026-09-09T01:26:10.319632Z","steps":["trace[794385679] 'agreement among raft nodes before linearized reading'  (duration: 138.939483ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:27:09.778806Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"68b29b9453c9d66d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-09T01:27:09.789622Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-09-09T01:27:09.789769Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-09-09T01:28:46.300055Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7911}
{"level":"info","ts":"2026-09-09T01:28:46.394627Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7911,"took":"91.085188ms","hash":505385092,"current-db-size-bytes":53964800,"current-db-size":"54 MB","current-db-size-in-use-bytes":26238976,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-09-09T01:28:46.394691Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":505385092,"revision":7911,"compact-revision":5370}
{"level":"info","ts":"2026-09-09T01:29:25.75116Z","caller":"traceutil/trace.go:171","msg":"trace[321224187] transaction","detail":"{read_only:false; response_revision:10638; number_of_response:1; }","duration":"127.735708ms","start":"2026-09-09T01:29:25.623399Z","end":"2026-09-09T01:29:25.751135Z","steps":["trace[321224187] 'process raft request'  (duration: 105.446914ms)","trace[321224187] 'compare'  (duration: 22.168841ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:31:12.423907Z","caller":"traceutil/trace.go:171","msg":"trace[1908480043] linearizableReadLoop","detail":"{readStateIndex:12054; appliedIndex:12053; }","duration":"199.145485ms","start":"2026-09-09T01:31:12.224735Z","end":"2026-09-09T01:31:12.42388Z","steps":["trace[1908480043] 'read index received'  (duration: 198.875629ms)","trace[1908480043] 'applied index is now lower than readState.Index'  (duration: 268.996µs)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:31:12.424043Z","caller":"traceutil/trace.go:171","msg":"trace[1583889211] transaction","detail":"{read_only:false; response_revision:11645; number_of_response:1; }","duration":"273.464511ms","start":"2026-09-09T01:31:12.150568Z","end":"2026-09-09T01:31:12.424033Z","steps":["trace[1583889211] 'process raft request'  (duration: 273.128683ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:31:12.424297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.552565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-09-09T01:31:12.424335Z","caller":"traceutil/trace.go:171","msg":"trace[777032440] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11645; }","duration":"199.641746ms","start":"2026-09-09T01:31:12.224683Z","end":"2026-09-09T01:31:12.424325Z","steps":["trace[777032440] 'agreement among raft nodes before linearized reading'  (duration: 199.491003ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:31:12.425079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.503562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-09-09T01:31:12.425197Z","caller":"traceutil/trace.go:171","msg":"trace[852594636] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11645; }","duration":"176.690037ms","start":"2026-09-09T01:31:12.248483Z","end":"2026-09-09T01:31:12.425173Z","steps":["trace[852594636] 'agreement among raft nodes before linearized reading'  (duration: 175.795656ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:31:12.673048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.917763ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15451182384129522495 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:11637 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-09T01:31:12.673304Z","caller":"traceutil/trace.go:171","msg":"trace[928039474] linearizableReadLoop","detail":"{readStateIndex:12057; appliedIndex:12054; }","duration":"243.299517ms","start":"2026-09-09T01:31:12.429984Z","end":"2026-09-09T01:31:12.673284Z","steps":["trace[928039474] 'read index received'  (duration: 73.021866ms)","trace[928039474] 'applied index is now lower than readState.Index'  (duration: 170.276781ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:31:12.673409Z","caller":"traceutil/trace.go:171","msg":"trace[837363743] transaction","detail":"{read_only:false; response_revision:11647; number_of_response:1; }","duration":"244.491834ms","start":"2026-09-09T01:31:12.428907Z","end":"2026-09-09T01:31:12.673399Z","steps":["trace[837363743] 'process raft request'  (duration: 244.257558ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:31:12.673539Z","caller":"traceutil/trace.go:171","msg":"trace[242077536] transaction","detail":"{read_only:false; response_revision:11646; number_of_response:1; }","duration":"244.628137ms","start":"2026-09-09T01:31:12.428859Z","end":"2026-09-09T01:31:12.673487Z","steps":["trace[242077536] 'process raft request'  (duration: 74.187222ms)","trace[242077536] 'compare'  (duration: 169.8005ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:31:12.673593Z","caller":"traceutil/trace.go:171","msg":"trace[1636007381] transaction","detail":"{read_only:false; response_revision:11648; number_of_response:1; }","duration":"243.789658ms","start":"2026-09-09T01:31:12.429765Z","end":"2026-09-09T01:31:12.673555Z","steps":["trace[1636007381] 'process raft request'  (duration: 243.480051ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:31:12.673778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.624378ms","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-09-09T01:31:12.673796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.787618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-09-09T01:31:12.673862Z","caller":"traceutil/trace.go:171","msg":"trace[1350328205] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11648; }","duration":"241.768001ms","start":"2026-09-09T01:31:12.432073Z","end":"2026-09-09T01:31:12.673841Z","steps":["trace[1350328205] 'agreement among raft nodes before linearized reading'  (duration: 241.459565ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:31:12.673878Z","caller":"traceutil/trace.go:171","msg":"trace[1093491773] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:11648; }","duration":"243.90451ms","start":"2026-09-09T01:31:12.429952Z","end":"2026-09-09T01:31:12.673857Z","steps":["trace[1093491773] 'agreement among raft nodes before linearized reading'  (duration: 243.604413ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:31:12.904719Z","caller":"traceutil/trace.go:171","msg":"trace[153531422] transaction","detail":"{read_only:false; response_revision:11649; number_of_response:1; }","duration":"225.164796ms","start":"2026-09-09T01:31:12.679527Z","end":"2026-09-09T01:31:12.904692Z","steps":["trace[153531422] 'process raft request'  (duration: 149.868499ms)","trace[153531422] 'compare'  (duration: 75.043912ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:31:12.904915Z","caller":"traceutil/trace.go:171","msg":"trace[95057690] transaction","detail":"{read_only:false; response_revision:11650; number_of_response:1; }","duration":"225.260409ms","start":"2026-09-09T01:31:12.679622Z","end":"2026-09-09T01:31:12.904882Z","steps":["trace[95057690] 'process raft request'  (duration: 224.977952ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:31:13.144035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.861218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-09-09T01:31:13.144118Z","caller":"traceutil/trace.go:171","msg":"trace[452257847] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:11650; }","duration":"138.97554ms","start":"2026-09-09T01:31:13.005124Z","end":"2026-09-09T01:31:13.144099Z","steps":["trace[452257847] 'range keys from in-memory index tree'  (duration: 138.684474ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:31:13.227321Z","caller":"traceutil/trace.go:171","msg":"trace[2084320262] linearizableReadLoop","detail":"{readStateIndex:12060; appliedIndex:12059; }","duration":"111.062928ms","start":"2026-09-09T01:31:13.116238Z","end":"2026-09-09T01:31:13.227301Z","steps":["trace[2084320262] 'read index received'  (duration: 110.816073ms)","trace[2084320262] 'applied index is now lower than readState.Index'  (duration: 245.515µs)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:31:13.22739Z","caller":"traceutil/trace.go:171","msg":"trace[350978662] transaction","detail":"{read_only:false; response_revision:11651; number_of_response:1; }","duration":"195.009192ms","start":"2026-09-09T01:31:13.032347Z","end":"2026-09-09T01:31:13.227356Z","steps":["trace[350978662] 'process raft request'  (duration: 194.801948ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:31:13.2275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.251423ms","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:5"}
{"level":"info","ts":"2026-09-09T01:31:13.227594Z","caller":"traceutil/trace.go:171","msg":"trace[1924848721] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:11651; }","duration":"111.409616ms","start":"2026-09-09T01:31:13.116168Z","end":"2026-09-09T01:31:13.227578Z","steps":["trace[1924848721] 'agreement among raft nodes before linearized reading'  (duration: 111.263653ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:31:13.227687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.025031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-09-09T01:31:13.227781Z","caller":"traceutil/trace.go:171","msg":"trace[1054587651] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:11651; }","duration":"101.133923ms","start":"2026-09-09T01:31:13.126603Z","end":"2026-09-09T01:31:13.227737Z","steps":["trace[1054587651] 'agreement among raft nodes before linearized reading'  (duration: 100.936809ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:31:13.633825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.263739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T01:31:13.633906Z","caller":"traceutil/trace.go:171","msg":"trace[198865616] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:11651; }","duration":"319.418093ms","start":"2026-09-09T01:31:13.314466Z","end":"2026-09-09T01:31:13.633885Z","steps":["trace[198865616] 'range keys from in-memory index tree'  (duration: 319.168317ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:31:13.633966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:31:13.314441Z","time spent":"319.507674ms","remote":"127.0.0.1:50170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"info","ts":"2026-09-09T01:31:13.684886Z","caller":"traceutil/trace.go:171","msg":"trace[801847114] transaction","detail":"{read_only:false; response_revision:11652; number_of_response:1; }","duration":"266.8386ms","start":"2026-09-09T01:31:13.417995Z","end":"2026-09-09T01:31:13.684833Z","steps":["trace[801847114] 'process raft request'  (duration: 266.600025ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:31:14.231121Z","caller":"traceutil/trace.go:171","msg":"trace[457929297] transaction","detail":"{read_only:false; response_revision:11654; number_of_response:1; }","duration":"140.539616ms","start":"2026-09-09T01:31:14.090555Z","end":"2026-09-09T01:31:14.231094Z","steps":["trace[457929297] 'process raft request'  (duration: 140.366032ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:33:46.307145Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10347}
{"level":"info","ts":"2026-09-09T01:33:46.389396Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10347,"took":"78.768788ms","hash":2143843343,"current-db-size-bytes":53964800,"current-db-size":"54 MB","current-db-size-in-use-bytes":28454912,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-09T01:33:46.389473Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2143843343,"revision":10347,"compact-revision":7911}
{"level":"warn","ts":"2026-09-09T01:37:31.164262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.075713ms","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-09-09T01:37:31.164361Z","caller":"traceutil/trace.go:171","msg":"trace[423394608] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14188; }","duration":"120.192346ms","start":"2026-09-09T01:37:31.044146Z","end":"2026-09-09T01:37:31.164339Z","steps":["trace[423394608] 'range keys from in-memory index tree'  (duration: 119.868199ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:37:54.650701Z","caller":"traceutil/trace.go:171","msg":"trace[416193567] transaction","detail":"{read_only:false; response_revision:14304; number_of_response:1; }","duration":"223.057058ms","start":"2026-09-09T01:37:54.427622Z","end":"2026-09-09T01:37:54.650679Z","steps":["trace[416193567] 'process raft request'  (duration: 222.897504ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:37:54.872227Z","caller":"traceutil/trace.go:171","msg":"trace[1262004140] transaction","detail":"{read_only:false; response_revision:14305; number_of_response:1; }","duration":"107.329724ms","start":"2026-09-09T01:37:54.764875Z","end":"2026-09-09T01:37:54.872205Z","steps":["trace[1262004140] 'process raft request'  (duration: 107.15949ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:38:13.176334Z","caller":"traceutil/trace.go:171","msg":"trace[1146859184] linearizableReadLoop","detail":"{readStateIndex:14930; appliedIndex:14929; }","duration":"174.982303ms","start":"2026-09-09T01:38:13.001292Z","end":"2026-09-09T01:38:13.176275Z","steps":["trace[1146859184] 'read index received'  (duration: 27.308841ms)","trace[1146859184] 'applied index is now lower than readState.Index'  (duration: 147.671692ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:38:13.176388Z","caller":"traceutil/trace.go:171","msg":"trace[290428097] transaction","detail":"{read_only:false; response_revision:14421; number_of_response:1; }","duration":"178.819421ms","start":"2026-09-09T01:38:12.997508Z","end":"2026-09-09T01:38:13.176328Z","steps":["trace[290428097] 'process raft request'  (duration: 178.517145ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:38:13.176576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.273199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-09T01:38:13.176684Z","caller":"traceutil/trace.go:171","msg":"trace[1357212177] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:14421; }","duration":"175.412963ms","start":"2026-09-09T01:38:13.00125Z","end":"2026-09-09T01:38:13.176663Z","steps":["trace[1357212177] 'agreement among raft nodes before linearized reading'  (duration: 175.259709ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:38:14.422854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.540558ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15451182384129530537 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:14411 > 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-09-09T01:38:14.422986Z","caller":"traceutil/trace.go:171","msg":"trace[1055349590] linearizableReadLoop","detail":"{readStateIndex:14934; appliedIndex:14933; }","duration":"755.97956ms","start":"2026-09-09T01:38:13.666975Z","end":"2026-09-09T01:38:14.422954Z","steps":["trace[1055349590] 'read index received'  (duration: 417.333271ms)","trace[1055349590] 'applied index is now lower than readState.Index'  (duration: 338.644669ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:38:14.423139Z","caller":"traceutil/trace.go:171","msg":"trace[898427984] transaction","detail":"{read_only:false; response_revision:14425; number_of_response:1; }","duration":"875.86126ms","start":"2026-09-09T01:38:13.547113Z","end":"2026-09-09T01:38:14.422975Z","steps":["trace[898427984] 'process raft request'  (duration: 537.097527ms)","trace[898427984] 'compare'  (duration: 338.310613ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:38:14.423329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:38:13.547093Z","time spent":"876.131757ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:14411 > 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":"warn","ts":"2026-09-09T01:38:14.423814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"756.833139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:86 size:930190"}
{"level":"info","ts":"2026-09-09T01:38:14.423884Z","caller":"traceutil/trace.go:171","msg":"trace[1050470544] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:86; response_revision:14425; }","duration":"756.942022ms","start":"2026-09-09T01:38:13.666933Z","end":"2026-09-09T01:38:14.423875Z","steps":["trace[1050470544] 'agreement among raft nodes before linearized reading'  (duration: 756.080573ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:38:14.423927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:38:13.666912Z","time spent":"757.004034ms","remote":"127.0.0.1:49854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":86,"response size":930213,"request content":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" "}
{"level":"info","ts":"2026-09-09T01:38:14.429076Z","caller":"traceutil/trace.go:171","msg":"trace[2033476033] transaction","detail":"{read_only:false; response_revision:14426; number_of_response:1; }","duration":"678.553468ms","start":"2026-09-09T01:38:13.750498Z","end":"2026-09-09T01:38:14.429052Z","steps":["trace[2033476033] 'process raft request'  (duration: 678.430365ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:38:14.429205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:38:13.750469Z","time spent":"678.670561ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:14369 > 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-09-09T01:38:46.316071Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12704}
{"level":"info","ts":"2026-09-09T01:38:46.413116Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12704,"took":"94.604413ms","hash":161429957,"current-db-size-bytes":53964800,"current-db-size":"54 MB","current-db-size-in-use-bytes":29159424,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-09-09T01:38:46.413176Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":161429957,"revision":12704,"compact-revision":10347}
{"level":"warn","ts":"2026-09-09T01:39:58.469341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.556338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-09T01:39:58.46942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.374418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"}
{"level":"warn","ts":"2026-09-09T01:39:58.469427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.934196ms","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-09-09T01:39:58.469503Z","caller":"traceutil/trace.go:171","msg":"trace[1871462135] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15644; }","duration":"242.747933ms","start":"2026-09-09T01:39:58.226724Z","end":"2026-09-09T01:39:58.469472Z","steps":["trace[1871462135] 'range keys from in-memory index tree'  (duration: 242.459426ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:39:58.469518Z","caller":"traceutil/trace.go:171","msg":"trace[487062239] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15644; }","duration":"243.516851ms","start":"2026-09-09T01:39:58.225974Z","end":"2026-09-09T01:39:58.469491Z","steps":["trace[487062239] 'range keys from in-memory index tree'  (duration: 243.190154ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:39:58.469359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.488855ms","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-09-09T01:39:58.46953Z","caller":"traceutil/trace.go:171","msg":"trace[970514723] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15644; }","duration":"239.06762ms","start":"2026-09-09T01:39:58.230445Z","end":"2026-09-09T01:39:58.469512Z","steps":["trace[970514723] 'range keys from in-memory index tree'  (duration: 238.740022ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:39:58.469578Z","caller":"traceutil/trace.go:171","msg":"trace[1507837700] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15644; }","duration":"241.780361ms","start":"2026-09-09T01:39:58.22778Z","end":"2026-09-09T01:39:58.46956Z","steps":["trace[1507837700] 'range keys from in-memory index tree'  (duration: 241.31751ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:39:58.910206Z","caller":"traceutil/trace.go:171","msg":"trace[247926724] transaction","detail":"{read_only:false; response_revision:15645; number_of_response:1; }","duration":"118.937102ms","start":"2026-09-09T01:39:58.791237Z","end":"2026-09-09T01:39:58.910174Z","steps":["trace[247926724] 'process raft request'  (duration: 118.784658ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:42:53.187671Z","caller":"traceutil/trace.go:171","msg":"trace[456434258] linearizableReadLoop","detail":"{readStateIndex:17613; appliedIndex:17612; }","duration":"166.545529ms","start":"2026-09-09T01:42:53.021104Z","end":"2026-09-09T01:42:53.187649Z","steps":["trace[456434258] 'read index received'  (duration: 166.323134ms)","trace[456434258] 'applied index is now lower than readState.Index'  (duration: 221.495µs)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:42:53.18796Z","caller":"traceutil/trace.go:171","msg":"trace[121302215] transaction","detail":"{read_only:false; response_revision:17023; number_of_response:1; }","duration":"169.151088ms","start":"2026-09-09T01:42:53.018797Z","end":"2026-09-09T01:42:53.187948Z","steps":["trace[121302215] 'process raft request'  (duration: 168.710538ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:42:53.188408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.734078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-ovn-metadata-agent-default-kpzfj\" ","response":"range_response_count:1 size:15437"}
{"level":"info","ts":"2026-09-09T01:42:53.188498Z","caller":"traceutil/trace.go:171","msg":"trace[1601211679] range","detail":"{range_begin:/registry/pods/openstack/neutron-ovn-metadata-agent-default-kpzfj; range_end:; response_count:1; response_revision:17023; }","duration":"149.85209ms","start":"2026-09-09T01:42:53.038626Z","end":"2026-09-09T01:42:53.188478Z","steps":["trace[1601211679] 'agreement among raft nodes before linearized reading'  (duration: 149.660116ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:42:53.188915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.811278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:89 size:882802"}
{"level":"info","ts":"2026-09-09T01:42:53.188955Z","caller":"traceutil/trace.go:171","msg":"trace[1903573399] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:89; response_revision:17023; }","duration":"167.87911ms","start":"2026-09-09T01:42:53.021066Z","end":"2026-09-09T01:42:53.188945Z","steps":["trace[1903573399] 'agreement among raft nodes before linearized reading'  (duration: 167.086421ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:43:46.350328Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14937}
{"level":"info","ts":"2026-09-09T01:43:46.461191Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14937,"took":"107.654113ms","hash":2925265293,"current-db-size-bytes":53964800,"current-db-size":"54 MB","current-db-size-in-use-bytes":30998528,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-09-09T01:43:46.461274Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2925265293,"revision":14937,"compact-revision":12704}
{"level":"warn","ts":"2026-09-09T01:45:33.213663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.8078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-09T01:45:33.213785Z","caller":"traceutil/trace.go:171","msg":"trace[1260522255] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:18180; }","duration":"204.994004ms","start":"2026-09-09T01:45:33.008765Z","end":"2026-09-09T01:45:33.213759Z","steps":["trace[1260522255] 'count revisions from in-memory index tree'  (duration: 204.668336ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:45:33.213995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.395501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-09-09T01:45:33.214141Z","caller":"traceutil/trace.go:171","msg":"trace[1437677753] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:18180; }","duration":"277.584465ms","start":"2026-09-09T01:45:32.936539Z","end":"2026-09-09T01:45:33.214124Z","steps":["trace[1437677753] 'count revisions from in-memory index tree'  (duration: 277.303219ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:45:33.214114Z","caller":"traceutil/trace.go:171","msg":"trace[1696280632] linearizableReadLoop","detail":"{readStateIndex:18810; appliedIndex:18809; }","duration":"144.806563ms","start":"2026-09-09T01:45:33.069275Z","end":"2026-09-09T01:45:33.214081Z","steps":["trace[1696280632] 'read index received'  (duration: 61.250975ms)","trace[1696280632] 'applied index is now lower than readState.Index'  (duration: 83.554038ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:45:33.214349Z","caller":"traceutil/trace.go:171","msg":"trace[1316194347] transaction","detail":"{read_only:false; response_revision:18181; number_of_response:1; }","duration":"171.337024ms","start":"2026-09-09T01:45:33.042988Z","end":"2026-09-09T01:45:33.214325Z","steps":["trace[1316194347] 'process raft request'  (duration: 87.543229ms)","trace[1316194347] 'compare'  (duration: 83.059647ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:45:33.214733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.269084ms","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-09-09T01:45:33.215096Z","caller":"traceutil/trace.go:171","msg":"trace[1586680896] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18181; }","duration":"145.812536ms","start":"2026-09-09T01:45:33.06926Z","end":"2026-09-09T01:45:33.215073Z","steps":["trace[1586680896] 'agreement among raft nodes before linearized reading'  (duration: 145.036939ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:45:38.969495Z","caller":"traceutil/trace.go:171","msg":"trace[110347912] transaction","detail":"{read_only:false; response_revision:18225; number_of_response:1; }","duration":"142.036171ms","start":"2026-09-09T01:45:38.82743Z","end":"2026-09-09T01:45:38.969466Z","steps":["trace[110347912] 'process raft request'  (duration: 141.826997ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:45:39.46068Z","caller":"traceutil/trace.go:171","msg":"trace[92364237] linearizableReadLoop","detail":"{readStateIndex:18856; appliedIndex:18855; }","duration":"219.352338ms","start":"2026-09-09T01:45:39.241302Z","end":"2026-09-09T01:45:39.460655Z","steps":["trace[92364237] 'read index received'  (duration: 219.148834ms)","trace[92364237] 'applied index is now lower than readState.Index'  (duration: 202.674µs)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:45:39.461002Z","caller":"traceutil/trace.go:171","msg":"trace[1682417216] transaction","detail":"{read_only:false; response_revision:18226; number_of_response:1; }","duration":"228.783731ms","start":"2026-09-09T01:45:39.232191Z","end":"2026-09-09T01:45:39.460975Z","steps":["trace[1682417216] 'process raft request'  (duration: 228.320841ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:45:39.461152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.796539ms","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-09-09T01:45:39.461191Z","caller":"traceutil/trace.go:171","msg":"trace[158922150] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18226; }","duration":"219.912191ms","start":"2026-09-09T01:45:39.241268Z","end":"2026-09-09T01:45:39.46118Z","steps":["trace[158922150] 'agreement among raft nodes before linearized reading'  (duration: 219.720517ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:45:39.887443Z","caller":"traceutil/trace.go:171","msg":"trace[1240691867] transaction","detail":"{read_only:false; response_revision:18228; number_of_response:1; }","duration":"421.484329ms","start":"2026-09-09T01:45:39.46593Z","end":"2026-09-09T01:45:39.887414Z","steps":["trace[1240691867] 'process raft request'  (duration: 353.608494ms)","trace[1240691867] 'compare'  (duration: 67.663551ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:45:39.887599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:45:39.465919Z","time spent":"421.595682ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:18214 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-09-09T01:45:39.887792Z","caller":"traceutil/trace.go:171","msg":"trace[966502445] linearizableReadLoop","detail":"{readStateIndex:18859; appliedIndex:18857; }","duration":"309.351594ms","start":"2026-09-09T01:45:39.578404Z","end":"2026-09-09T01:45:39.887756Z","steps":["trace[966502445] 'read index received'  (duration: 241.07918ms)","trace[966502445] 'applied index is now lower than readState.Index'  (duration: 68.270094ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:45:39.887986Z","caller":"traceutil/trace.go:171","msg":"trace[91837847] transaction","detail":"{read_only:false; response_revision:18229; number_of_response:1; }","duration":"412.472245ms","start":"2026-09-09T01:45:39.475497Z","end":"2026-09-09T01:45:39.887969Z","steps":["trace[91837847] 'process raft request'  (duration: 411.875311ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:45:39.888124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:45:39.475473Z","time spent":"412.545266ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:18213 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-09-09T01:45:39.88828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.742884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-09T01:45:39.888343Z","caller":"traceutil/trace.go:171","msg":"trace[388325284] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18229; }","duration":"187.852497ms","start":"2026-09-09T01:45:39.70047Z","end":"2026-09-09T01:45:39.888323Z","steps":["trace[388325284] 'agreement among raft nodes before linearized reading'  (duration: 187.695563ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:45:39.888377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.973368ms","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":"warn","ts":"2026-09-09T01:45:39.888397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.558427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-09T01:45:39.888432Z","caller":"traceutil/trace.go:171","msg":"trace[1850982234] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18229; }","duration":"310.06443ms","start":"2026-09-09T01:45:39.578348Z","end":"2026-09-09T01:45:39.888413Z","steps":["trace[1850982234] 'agreement among raft nodes before linearized reading'  (duration: 309.849885ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:45:39.888459Z","caller":"traceutil/trace.go:171","msg":"trace[1077737006] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:18229; }","duration":"247.666048ms","start":"2026-09-09T01:45:39.640775Z","end":"2026-09-09T01:45:39.888441Z","steps":["trace[1077737006] 'agreement among raft nodes before linearized reading'  (duration: 247.515505ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:45:39.888435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.413434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"warn","ts":"2026-09-09T01:45:39.88845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.159379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" ","response":"range_response_count:1 size:3226"}
{"level":"warn","ts":"2026-09-09T01:45:39.888479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:45:39.578327Z","time spent":"310.139662ms","remote":"127.0.0.1:49996","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":"info","ts":"2026-09-09T01:45:39.888517Z","caller":"traceutil/trace.go:171","msg":"trace[2119310786] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18229; }","duration":"309.529977ms","start":"2026-09-09T01:45:39.578967Z","end":"2026-09-09T01:45:39.888497Z","steps":["trace[2119310786] 'agreement among raft nodes before linearized reading'  (duration: 309.20449ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:45:39.88854Z","caller":"traceutil/trace.go:171","msg":"trace[1337251549] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat; range_end:; response_count:1; response_revision:18229; }","duration":"225.347564ms","start":"2026-09-09T01:45:39.663167Z","end":"2026-09-09T01:45:39.888515Z","steps":["trace[1337251549] 'agreement among raft nodes before linearized reading'  (duration: 225.010576ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:45:39.88856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:45:39.578961Z","time spent":"309.588539ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-09-09T01:45:40.053372Z","caller":"traceutil/trace.go:171","msg":"trace[1927031315] transaction","detail":"{read_only:false; response_revision:18231; number_of_response:1; }","duration":"159.438714ms","start":"2026-09-09T01:45:39.893906Z","end":"2026-09-09T01:45:40.053345Z","steps":["trace[1927031315] 'process raft request'  (duration: 151.415463ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:47:42.466952Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"68b29b9453c9d66d","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-09T01:47:42.504593Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-09-09T01:47:42.50474Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-09-09T01:48:46.358507Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17357}
{"level":"info","ts":"2026-09-09T01:48:46.472639Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17357,"took":"110.796615ms","hash":2841530473,"current-db-size-bytes":53964800,"current-db-size":"54 MB","current-db-size-in-use-bytes":34869248,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-09-09T01:48:46.472711Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2841530473,"revision":17357,"compact-revision":14937}
{"level":"info","ts":"2026-09-09T01:50:40.566742Z","caller":"traceutil/trace.go:171","msg":"trace[625607705] linearizableReadLoop","detail":"{readStateIndex:21296; appliedIndex:21295; }","duration":"128.070085ms","start":"2026-09-09T01:50:40.438648Z","end":"2026-09-09T01:50:40.566719Z","steps":["trace[625607705] 'read index received'  (duration: 127.86535ms)","trace[625607705] 'applied index is now lower than readState.Index'  (duration: 203.495µs)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:50:40.566833Z","caller":"traceutil/trace.go:171","msg":"trace[697948057] transaction","detail":"{read_only:false; response_revision:20588; number_of_response:1; }","duration":"138.534083ms","start":"2026-09-09T01:50:40.428259Z","end":"2026-09-09T01:50:40.566793Z","steps":["trace[697948057] 'process raft request'  (duration: 138.306067ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:40.566952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.285801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.179\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-09-09T01:50:40.566985Z","caller":"traceutil/trace.go:171","msg":"trace[557058405] range","detail":"{range_begin:/registry/masterleases/162.253.55.179; range_end:; response_count:1; response_revision:20588; }","duration":"128.368883ms","start":"2026-09-09T01:50:40.438606Z","end":"2026-09-09T01:50:40.566975Z","steps":["trace[557058405] 'agreement among raft nodes before linearized reading'  (duration: 128.2382ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:40.567003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.335031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-09T01:50:40.567055Z","caller":"traceutil/trace.go:171","msg":"trace[2086474784] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:20588; }","duration":"124.433033ms","start":"2026-09-09T01:50:40.442608Z","end":"2026-09-09T01:50:40.567041Z","steps":["trace[2086474784] 'agreement among raft nodes before linearized reading'  (duration: 124.321961ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:46.319152Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15451182384129551067,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-09-09T01:50:46.357383Z","caller":"traceutil/trace.go:171","msg":"trace[1263218011] transaction","detail":"{read_only:false; response_revision:20618; number_of_response:1; }","duration":"580.040864ms","start":"2026-09-09T01:50:45.777315Z","end":"2026-09-09T01:50:46.357356Z","steps":["trace[1263218011] 'process raft request'  (duration: 579.855989ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:46.357542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:45.777298Z","time spent":"580.172927ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:20607 > 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-09-09T01:50:47.120686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.376406ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15451182384129551069 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:20609 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-09T01:50:47.120848Z","caller":"traceutil/trace.go:171","msg":"trace[476145329] transaction","detail":"{read_only:false; response_revision:20620; number_of_response:1; }","duration":"390.499877ms","start":"2026-09-09T01:50:46.730333Z","end":"2026-09-09T01:50:47.120833Z","steps":["trace[476145329] 'process raft request'  (duration: 390.442376ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:47.12092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:46.730309Z","time spent":"390.574439ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:20611 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-09-09T01:50:47.120987Z","caller":"traceutil/trace.go:171","msg":"trace[1915438121] linearizableReadLoop","detail":"{readStateIndex:21329; appliedIndex:21327; }","duration":"1.302395683s","start":"2026-09-09T01:50:45.818502Z","end":"2026-09-09T01:50:47.120897Z","steps":["trace[1915438121] 'read index received'  (duration: 538.590585ms)","trace[1915438121] 'applied index is now lower than readState.Index'  (duration: 763.801868ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:50:47.121167Z","caller":"traceutil/trace.go:171","msg":"trace[750778374] transaction","detail":"{read_only:false; response_revision:20619; number_of_response:1; }","duration":"1.16560357s","start":"2026-09-09T01:50:45.955548Z","end":"2026-09-09T01:50:47.121152Z","steps":["trace[750778374] 'process raft request'  (duration: 958.684713ms)","trace[750778374] 'compare'  (duration: 205.939666ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:50:47.121296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:45.95552Z","time spent":"1.165674811s","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:20609 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-09-09T01:50:47.121507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.08107432s","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":"warn","ts":"2026-09-09T01:50:47.121487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.750522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-09-09T01:50:47.121526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.236876ms","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-09-09T01:50:47.121554Z","caller":"traceutil/trace.go:171","msg":"trace[128018083] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20620; }","duration":"1.081153701s","start":"2026-09-09T01:50:46.040384Z","end":"2026-09-09T01:50:47.121538Z","steps":["trace[128018083] 'agreement among raft nodes before linearized reading'  (duration: 1.080994587s)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:47.12159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:46.040366Z","time spent":"1.081216923s","remote":"127.0.0.1:49996","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":"info","ts":"2026-09-09T01:50:47.121581Z","caller":"traceutil/trace.go:171","msg":"trace[1334630374] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20620; }","duration":"420.908175ms","start":"2026-09-09T01:50:46.700647Z","end":"2026-09-09T01:50:47.121556Z","steps":["trace[1334630374] 'agreement among raft nodes before linearized reading'  (duration: 420.729791ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:47.121585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.303071057s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"}
{"level":"warn","ts":"2026-09-09T01:50:47.121636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:46.700628Z","time spent":"420.996157ms","remote":"127.0.0.1:49748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-09-09T01:50:47.121701Z","caller":"traceutil/trace.go:171","msg":"trace[941738700] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:20620; }","duration":"1.303234771s","start":"2026-09-09T01:50:45.818415Z","end":"2026-09-09T01:50:47.12165Z","steps":["trace[941738700] 'agreement among raft nodes before linearized reading'  (duration: 1.302957705s)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:47.1217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.96357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1858"}
{"level":"warn","ts":"2026-09-09T01:50:47.121759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:45.818394Z","time spent":"1.303352464s","remote":"127.0.0.1:49936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-09-09T01:50:47.121769Z","caller":"traceutil/trace.go:171","msg":"trace[2044701494] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:20620; }","duration":"150.070492ms","start":"2026-09-09T01:50:46.971676Z","end":"2026-09-09T01:50:47.121746Z","steps":["trace[2044701494] 'agreement among raft nodes before linearized reading'  (duration: 149.848337ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:50:47.121593Z","caller":"traceutil/trace.go:171","msg":"trace[1927954773] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:20620; }","duration":"576.346709ms","start":"2026-09-09T01:50:46.545224Z","end":"2026-09-09T01:50:47.121571Z","steps":["trace[1927954773] 'agreement among raft nodes before linearized reading'  (duration: 576.179515ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:47.121842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"761.885083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:26 size:234073"}
{"level":"warn","ts":"2026-09-09T01:50:47.121877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:46.545205Z","time spent":"576.634355ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "}
{"level":"info","ts":"2026-09-09T01:50:47.12191Z","caller":"traceutil/trace.go:171","msg":"trace[1598537161] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:26; response_revision:20620; }","duration":"761.997316ms","start":"2026-09-09T01:50:46.359892Z","end":"2026-09-09T01:50:47.12189Z","steps":["trace[1598537161] 'agreement among raft nodes before linearized reading'  (duration: 761.490325ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:47.121959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:46.359867Z","time spent":"762.078588ms","remote":"127.0.0.1:50170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":26,"response size":234096,"request content":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" "}
{"level":"warn","ts":"2026-09-09T01:50:47.12241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"967.870751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-09T01:50:47.122544Z","caller":"traceutil/trace.go:171","msg":"trace[1988049308] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:20620; }","duration":"968.107267ms","start":"2026-09-09T01:50:46.154404Z","end":"2026-09-09T01:50:47.122511Z","steps":["trace[1988049308] 'agreement among raft nodes before linearized reading'  (duration: 967.145464ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:47.122604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:46.154384Z","time spent":"968.201468ms","remote":"127.0.0.1:49894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "}
{"level":"warn","ts":"2026-09-09T01:50:47.627624Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15451182384129551075,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-09-09T01:50:47.832541Z","caller":"traceutil/trace.go:171","msg":"trace[1386594253] transaction","detail":"{read_only:false; response_revision:20621; number_of_response:1; }","duration":"706.734256ms","start":"2026-09-09T01:50:47.125783Z","end":"2026-09-09T01:50:47.832518Z","steps":["trace[1386594253] 'process raft request'  (duration: 706.562282ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:47.832683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:47.125763Z","time spent":"706.843889ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:20612 > 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-09-09T01:50:47.882574Z","caller":"traceutil/trace.go:171","msg":"trace[325194595] linearizableReadLoop","detail":"{readStateIndex:21333; appliedIndex:21330; }","duration":"755.703184ms","start":"2026-09-09T01:50:47.126847Z","end":"2026-09-09T01:50:47.88255Z","steps":["trace[325194595] 'read index received'  (duration: 705.443668ms)","trace[325194595] 'applied index is now lower than readState.Index'  (duration: 50.258326ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:50:47.882607Z","caller":"traceutil/trace.go:171","msg":"trace[1090229977] transaction","detail":"{read_only:false; response_revision:20622; number_of_response:1; }","duration":"756.595314ms","start":"2026-09-09T01:50:47.125983Z","end":"2026-09-09T01:50:47.882578Z","steps":["trace[1090229977] 'process raft request'  (duration: 756.337108ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:50:47.882669Z","caller":"traceutil/trace.go:171","msg":"trace[849900483] transaction","detail":"{read_only:false; response_revision:20623; number_of_response:1; }","duration":"363.422376ms","start":"2026-09-09T01:50:47.519196Z","end":"2026-09-09T01:50:47.882619Z","steps":["trace[849900483] 'process raft request'  (duration: 363.306003ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:47.882824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"755.96054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19263"}
{"level":"info","ts":"2026-09-09T01:50:47.882862Z","caller":"traceutil/trace.go:171","msg":"trace[1000162679] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:20623; }","duration":"756.055422ms","start":"2026-09-09T01:50:47.126797Z","end":"2026-09-09T01:50:47.882853Z","steps":["trace[1000162679] 'agreement among raft nodes before linearized reading'  (duration: 755.875418ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:47.88289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:47.126779Z","time spent":"756.103333ms","remote":"127.0.0.1:49934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":19286,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-09-09T01:50:47.882875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:47.125958Z","time spent":"756.763608ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:20610 > 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":"warn","ts":"2026-09-09T01:50:47.882905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:47.519173Z","time spent":"363.60316ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:20613 > 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":"warn","ts":"2026-09-09T01:50:47.883044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.691831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1866"}
{"level":"info","ts":"2026-09-09T01:50:47.883111Z","caller":"traceutil/trace.go:171","msg":"trace[508541318] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:20623; }","duration":"754.786112ms","start":"2026-09-09T01:50:47.128307Z","end":"2026-09-09T01:50:47.883093Z","steps":["trace[508541318] 'agreement among raft nodes before linearized reading'  (duration: 754.576608ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:47.883139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:47.128294Z","time spent":"754.837733ms","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1889,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "}
{"level":"warn","ts":"2026-09-09T01:50:47.883148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.325438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-09-09T01:50:47.883162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.244549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-09-09T01:50:47.883182Z","caller":"traceutil/trace.go:171","msg":"trace[268613815] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20623; }","duration":"307.389519ms","start":"2026-09-09T01:50:47.575782Z","end":"2026-09-09T01:50:47.883171Z","steps":["trace[268613815] 'agreement among raft nodes before linearized reading'  (duration: 307.268746ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:47.883164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.125343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:119"}
{"level":"info","ts":"2026-09-09T01:50:47.883217Z","caller":"traceutil/trace.go:171","msg":"trace[582425915] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20623; }","duration":"212.340701ms","start":"2026-09-09T01:50:47.67086Z","end":"2026-09-09T01:50:47.883201Z","steps":["trace[582425915] 'agreement among raft nodes before linearized reading'  (duration: 212.176407ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:47.883215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:47.575764Z","time spent":"307.445671ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-09-09T01:50:47.88325Z","caller":"traceutil/trace.go:171","msg":"trace[1928541290] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:20623; }","duration":"146.255366ms","start":"2026-09-09T01:50:47.736974Z","end":"2026-09-09T01:50:47.883229Z","steps":["trace[1928541290] 'agreement among raft nodes before linearized reading'  (duration: 146.003481ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:47.883421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.212014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-09-09T01:50:47.883497Z","caller":"traceutil/trace.go:171","msg":"trace[1206537698] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20623; }","duration":"211.277495ms","start":"2026-09-09T01:50:47.672175Z","end":"2026-09-09T01:50:47.883452Z","steps":["trace[1206537698] 'agreement among raft nodes before linearized reading'  (duration: 211.160153ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:47.883512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.153655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130878"}
{"level":"info","ts":"2026-09-09T01:50:47.883542Z","caller":"traceutil/trace.go:171","msg":"trace[690914944] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:20623; }","duration":"104.234056ms","start":"2026-09-09T01:50:47.779298Z","end":"2026-09-09T01:50:47.883532Z","steps":["trace[690914944] 'agreement among raft nodes before linearized reading'  (duration: 104.092783ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:48.325773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.433722ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15451182384129551084 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:20616 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-09T01:50:48.325967Z","caller":"traceutil/trace.go:171","msg":"trace[1921370632] linearizableReadLoop","detail":"{readStateIndex:21336; appliedIndex:21334; }","duration":"414.988851ms","start":"2026-09-09T01:50:47.910962Z","end":"2026-09-09T01:50:48.325951Z","steps":["trace[1921370632] 'read index received'  (duration: 210.230072ms)","trace[1921370632] 'applied index is now lower than readState.Index'  (duration: 204.757789ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:50:48.326058Z","caller":"traceutil/trace.go:171","msg":"trace[1292317820] transaction","detail":"{read_only:false; response_revision:20626; number_of_response:1; }","duration":"436.107668ms","start":"2026-09-09T01:50:47.889938Z","end":"2026-09-09T01:50:48.326046Z","steps":["trace[1292317820] 'process raft request'  (duration: 435.918214ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:48.32618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:47.889922Z","time spent":"436.21298ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:20617 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-09-09T01:50:48.326343Z","caller":"traceutil/trace.go:171","msg":"trace[591543809] transaction","detail":"{read_only:false; response_revision:20625; number_of_response:1; }","duration":"437.583062ms","start":"2026-09-09T01:50:47.888718Z","end":"2026-09-09T01:50:48.326301Z","steps":["trace[591543809] 'process raft request'  (duration: 232.554897ms)","trace[591543809] 'compare'  (duration: 204.246547ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:50:48.3264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.413421ms","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-09-09T01:50:48.326516Z","caller":"traceutil/trace.go:171","msg":"trace[1357562705] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:20626; }","duration":"373.554945ms","start":"2026-09-09T01:50:47.952926Z","end":"2026-09-09T01:50:48.326481Z","steps":["trace[1357562705] 'agreement among raft nodes before linearized reading'  (duration: 373.392441ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:48.326505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.641051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-09-09T01:50:48.326536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:47.8887Z","time spent":"437.718615ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:20616 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-09-09T01:50:48.326563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:47.952877Z","time spent":"373.675987ms","remote":"127.0.0.1:50170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"warn","ts":"2026-09-09T01:50:48.326558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.328861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130878"}
{"level":"info","ts":"2026-09-09T01:50:48.326595Z","caller":"traceutil/trace.go:171","msg":"trace[970054772] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:20626; }","duration":"394.809875ms","start":"2026-09-09T01:50:47.931759Z","end":"2026-09-09T01:50:48.326568Z","steps":["trace[970054772] 'agreement among raft nodes before linearized reading'  (duration: 394.60722ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:50:48.326631Z","caller":"traceutil/trace.go:171","msg":"trace[1298242895] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:20626; }","duration":"408.446794ms","start":"2026-09-09T01:50:47.918166Z","end":"2026-09-09T01:50:48.326612Z","steps":["trace[1298242895] 'agreement among raft nodes before linearized reading'  (duration: 408.143616ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:48.326663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:47.931737Z","time spent":"394.908127ms","remote":"127.0.0.1:50050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "}
{"level":"warn","ts":"2026-09-09T01:50:48.326677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:47.918146Z","time spent":"408.517236ms","remote":"127.0.0.1:49824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":130901,"request content":"key:\"/registry/ranges/serviceips\" "}
{"level":"warn","ts":"2026-09-09T01:50:48.326526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.361456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:119"}
{"level":"info","ts":"2026-09-09T01:50:48.326806Z","caller":"traceutil/trace.go:171","msg":"trace[107212790] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:20626; }","duration":"433.613002ms","start":"2026-09-09T01:50:47.893121Z","end":"2026-09-09T01:50:48.326734Z","steps":["trace[107212790] 'agreement among raft nodes before linearized reading'  (duration: 433.220313ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-09T01:50:48.326862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:47.893111Z","time spent":"433.734946ms","remote":"127.0.0.1:49828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":142,"request content":"key:\"/registry/ranges/servicenodeports\" "}
{"level":"info","ts":"2026-09-09T01:50:48.657347Z","caller":"traceutil/trace.go:171","msg":"trace[1495118543] transaction","detail":"{read_only:false; response_revision:20627; number_of_response:1; }","duration":"292.403841ms","start":"2026-09-09T01:50:48.364919Z","end":"2026-09-09T01:50:48.657323Z","steps":["trace[1495118543] 'process raft request'  (duration: 292.234817ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:50:49.342003Z","caller":"traceutil/trace.go:171","msg":"trace[503371731] transaction","detail":"{read_only:false; response_revision:20628; number_of_response:1; }","duration":"215.308247ms","start":"2026-09-09T01:50:49.126668Z","end":"2026-09-09T01:50:49.341976Z","steps":["trace[503371731] 'process raft request'  (duration: 215.112573ms)"],"step_count":1}
{"level":"info","ts":"2026-09-09T01:50:49.44205Z","caller":"traceutil/trace.go:171","msg":"trace[1762406795] transaction","detail":"{read_only:false; response_revision:20629; number_of_response:1; }","duration":"315.218947ms","start":"2026-09-09T01:50:49.126788Z","end":"2026-09-09T01:50:49.442007Z","steps":["trace[1762406795] 'process raft request'  (duration: 268.635023ms)","trace[1762406795] 'compare'  (duration: 46.387209ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-09T01:50:49.442262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-09T01:50:49.12675Z","time spent":"315.3836ms","remote":"127.0.0.1:49996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:20619 > 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-09-09T01:53:46.366167Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19772}
{"level":"info","ts":"2026-09-09T01:53:46.493487Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19772,"took":"121.971853ms","hash":1008331085,"current-db-size-bytes":53964800,"current-db-size":"54 MB","current-db-size-in-use-bytes":29466624,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-09T01:53:46.493555Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1008331085,"revision":19772,"compact-revision":17357}
{"level":"info","ts":"2026-09-09T01:54:40.661172Z","caller":"traceutil/trace.go:171","msg":"trace[299999144] transaction","detail":"{read_only:false; response_revision:23017; number_of_response:1; }","duration":"128.301167ms","start":"2026-09-09T01:54:40.532842Z","end":"2026-09-09T01:54:40.661143Z","steps":["trace[299999144] 'process raft request'  (duration: 116.725064ms)","trace[299999144] 'compare'  (duration: 11.168514ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:54:41.082041Z","caller":"traceutil/trace.go:171","msg":"trace[445230915] transaction","detail":"{read_only:false; response_revision:23018; number_of_response:1; }","duration":"281.798256ms","start":"2026-09-09T01:54:40.800218Z","end":"2026-09-09T01:54:41.082016Z","steps":["trace[445230915] 'process raft request'  (duration: 256.803499ms)","trace[445230915] 'compare'  (duration: 24.467425ms)"],"step_count":2}
2026/09/09 01:55:00 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"info","ts":"2026-09-09T01:55:50.551604Z","caller":"traceutil/trace.go:171","msg":"trace[1890200826] transaction","detail":"{read_only:false; response_revision:23858; number_of_response:1; }","duration":"100.760763ms","start":"2026-09-09T01:55:50.450803Z","end":"2026-09-09T01:55:50.551564Z","steps":["trace[1890200826] 'process raft request'  (duration: 79.378309ms)","trace[1890200826] 'compare'  (duration: 21.20605ms)"],"step_count":2}
{"level":"info","ts":"2026-09-09T01:58:46.373726Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21995}
{"level":"info","ts":"2026-09-09T01:58:46.483748Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21995,"took":"105.428948ms","hash":1501116288,"current-db-size-bytes":53964800,"current-db-size":"54 MB","current-db-size-in-use-bytes":41811968,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-09-09T01:58:46.483833Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1501116288,"revision":21995,"compact-revision":19772}
{"level":"info","ts":"2026-09-09T02:03:46.384115Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25170}
{"level":"info","ts":"2026-09-09T02:03:46.521898Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25170,"took":"134.443516ms","hash":4011485660,"current-db-size-bytes":53964800,"current-db-size":"54 MB","current-db-size-in-use-bytes":30257152,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-09T02:03:46.521994Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4011485660,"revision":25170,"compact-revision":21995}