{"level":"warn","ts":"2026-07-22T22:05:57.150709Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-22T22:05:57.150783Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.23: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://199.204.45.23:2380","--initial-cluster=instance=https://199.204.45.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.23: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-07-22T22:05:57.15084Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-22T22:05:57.150853Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.23:2380"]}
{"level":"info","ts":"2026-07-22T22:05:57.150871Z","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-07-22T22:05:57.151449Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"]}
{"level":"info","ts":"2026-07-22T22:05:57.151517Z","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://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.23: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-07-22T22:05:57.155Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.284789ms"}
{"level":"info","ts":"2026-07-22T22:05:57.163676Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"51a5c416a4d98c86","cluster-id":"ade2045974c19907"}
{"level":"info","ts":"2026-07-22T22:05:57.163771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=()"}
{"level":"info","ts":"2026-07-22T22:05:57.163793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 0"}
{"level":"info","ts":"2026-07-22T22:05:57.163809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 51a5c416a4d98c86 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-07-22T22:05:57.163822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 1"}
{"level":"info","ts":"2026-07-22T22:05:57.163868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"}
{"level":"warn","ts":"2026-07-22T22:05:57.171884Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-07-22T22:05:57.174359Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-07-22T22:05:57.175456Z","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-07-22T22:05:57.178639Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"51a5c416a4d98c86","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-07-22T22:05:57.179297Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"51a5c416a4d98c86","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-07-22T22:05:57.179385Z","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-07-22T22:05:57.179418Z","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-07-22T22:05:57.179428Z","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-07-22T22:05:57.179802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"}
{"level":"info","ts":"2026-07-22T22:05:57.179902Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","added-peer-id":"51a5c416a4d98c86","added-peer-peer-urls":["https://199.204.45.23:2380"]}
{"level":"info","ts":"2026-07-22T22:05:57.181335Z","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-07-22T22:05:57.181516Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"51a5c416a4d98c86","initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-07-22T22:05:57.181546Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-07-22T22:05:57.181659Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.23:2380"}
{"level":"info","ts":"2026-07-22T22:05:57.181673Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.23:2380"}
{"level":"info","ts":"2026-07-22T22:05:57.864381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 is starting a new election at term 1"}
{"level":"info","ts":"2026-07-22T22:05:57.86448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became pre-candidate at term 1"}
{"level":"info","ts":"2026-07-22T22:05:57.864513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgPreVoteResp from 51a5c416a4d98c86 at term 1"}
{"level":"info","ts":"2026-07-22T22:05:57.864537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became candidate at term 2"}
{"level":"info","ts":"2026-07-22T22:05:57.864552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgVoteResp from 51a5c416a4d98c86 at term 2"}
{"level":"info","ts":"2026-07-22T22:05:57.864587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became leader at term 2"}
{"level":"info","ts":"2026-07-22T22:05:57.864605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 51a5c416a4d98c86 elected leader 51a5c416a4d98c86 at term 2"}
{"level":"info","ts":"2026-07-22T22:05:57.866075Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-22T22:05:57.869114Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-22T22:05:57.869117Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"51a5c416a4d98c86","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.23:2379]}","request-path":"/0/members/51a5c416a4d98c86/attributes","cluster-id":"ade2045974c19907","publish-timeout":"7s"}
{"level":"info","ts":"2026-07-22T22:05:57.869182Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-22T22:05:57.869683Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-22T22:05:57.869872Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-22T22:05:57.869912Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-22T22:05:57.87043Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-07-22T22:05:57.870512Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-07-22T22:05:57.870992Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.23:2379"}
{"level":"info","ts":"2026-07-22T22:05:57.872401Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-07-22T22:06:17.571392Z","caller":"traceutil/trace.go:171","msg":"trace[497016466] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"127.964687ms","start":"2026-07-22T22:06:17.443403Z","end":"2026-07-22T22:06:17.571368Z","steps":["trace[497016466] 'process raft request'  (duration: 91.554875ms)","trace[497016466] 'compare'  (duration: 36.277029ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:06:22.829496Z","caller":"traceutil/trace.go:171","msg":"trace[988172318] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"125.197822ms","start":"2026-07-22T22:06:22.70427Z","end":"2026-07-22T22:06:22.829468Z","steps":["trace[988172318] 'process raft request'  (duration: 125.060558ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:06:34.374077Z","caller":"traceutil/trace.go:171","msg":"trace[1505627166] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"209.54044ms","start":"2026-07-22T22:06:34.164492Z","end":"2026-07-22T22:06:34.374033Z","steps":["trace[1505627166] 'process raft request'  (duration: 178.028562ms)","trace[1505627166] 'compare'  (duration: 31.091467ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:06:34.374309Z","caller":"traceutil/trace.go:171","msg":"trace[269862748] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"179.879712ms","start":"2026-07-22T22:06:34.194371Z","end":"2026-07-22T22:06:34.374251Z","steps":["trace[269862748] 'process raft request'  (duration: 179.694217ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:06:40.220424Z","caller":"traceutil/trace.go:171","msg":"trace[851024719] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"113.901024ms","start":"2026-07-22T22:06:40.106496Z","end":"2026-07-22T22:06:40.220397Z","steps":["trace[851024719] 'process raft request'  (duration: 113.301178ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:06:40.995207Z","caller":"traceutil/trace.go:171","msg":"trace[550077468] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"334.327471ms","start":"2026-07-22T22:06:40.660857Z","end":"2026-07-22T22:06:40.995184Z","steps":["trace[550077468] 'process raft request'  (duration: 307.996474ms)","trace[550077468] 'compare'  (duration: 26.126512ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:06:40.995617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:06:40.66083Z","time spent":"334.433974ms","remote":"127.0.0.1:50528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-nzdvs\" mod_revision:517 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-nzdvs\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-nzdvs\" > >"}
{"level":"info","ts":"2026-07-22T22:06:41.13078Z","caller":"traceutil/trace.go:171","msg":"trace[368952998] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:661; }","duration":"294.015211ms","start":"2026-07-22T22:06:40.836707Z","end":"2026-07-22T22:06:41.130722Z","steps":["trace[368952998] 'read index received'  (duration: 132.243613ms)","trace[368952998] 'applied index is now lower than readState.Index'  (duration: 161.770458ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:06:41.130989Z","caller":"traceutil/trace.go:171","msg":"trace[1318230223] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"448.344387ms","start":"2026-07-22T22:06:40.682597Z","end":"2026-07-22T22:06:41.130941Z","steps":["trace[1318230223] 'process raft request'  (duration: 445.418527ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:06:41.131035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.886258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-07-22T22:06:41.13099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.262649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.23\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-07-22T22:06:41.131082Z","caller":"traceutil/trace.go:171","msg":"trace[1410852674] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:635; }","duration":"224.95935ms","start":"2026-07-22T22:06:40.906111Z","end":"2026-07-22T22:06:41.13107Z","steps":["trace[1410852674] 'agreement among raft nodes before linearized reading'  (duration: 224.797625ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:06:41.13114Z","caller":"traceutil/trace.go:171","msg":"trace[1961132597] range","detail":"{range_begin:/registry/masterleases/199.204.45.23; range_end:; response_count:1; response_revision:635; }","duration":"294.456334ms","start":"2026-07-22T22:06:40.836656Z","end":"2026-07-22T22:06:41.131112Z","steps":["trace[1961132597] 'agreement among raft nodes before linearized reading'  (duration: 294.246168ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:06:41.131169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:06:40.682565Z","time spent":"448.505542ms","remote":"127.0.0.1:50446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"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:631 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036225 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-07-22T22:07:52.161873Z","caller":"traceutil/trace.go:171","msg":"trace[2034834571] transaction","detail":"{read_only:false; response_revision:1469; number_of_response:1; }","duration":"116.138907ms","start":"2026-07-22T22:07:52.045686Z","end":"2026-07-22T22:07:52.161825Z","steps":["trace[2034834571] 'process raft request'  (duration: 115.89273ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:08:13.471997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.101171ms","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-07-22T22:08:13.472219Z","caller":"traceutil/trace.go:171","msg":"trace[1866959493] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1858; }","duration":"173.351148ms","start":"2026-07-22T22:08:13.298814Z","end":"2026-07-22T22:08:13.472165Z","steps":["trace[1866959493] 'range keys from in-memory index tree'  (duration: 172.899575ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:08:13.637379Z","caller":"traceutil/trace.go:171","msg":"trace[1007459024] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"160.190153ms","start":"2026-07-22T22:08:13.477156Z","end":"2026-07-22T22:08:13.637346Z","steps":["trace[1007459024] 'process raft request'  (duration: 159.958087ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:08:14.003173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.235497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-20f902fc-92ca-4190-87f0-286f9c51a253\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-07-22T22:08:14.003284Z","caller":"traceutil/trace.go:171","msg":"trace[1301695278] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-20f902fc-92ca-4190-87f0-286f9c51a253; range_end:; response_count:1; response_revision:1860; }","duration":"154.408802ms","start":"2026-07-22T22:08:13.848849Z","end":"2026-07-22T22:08:14.003258Z","steps":["trace[1301695278] 'range keys from in-memory index tree'  (duration: 154.027182ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:08:26.195796Z","caller":"traceutil/trace.go:171","msg":"trace[1563259908] transaction","detail":"{read_only:false; response_revision:1969; number_of_response:1; }","duration":"121.560601ms","start":"2026-07-22T22:08:26.074213Z","end":"2026-07-22T22:08:26.195773Z","steps":["trace[1563259908] 'process raft request'  (duration: 121.356845ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:08:58.470415Z","caller":"traceutil/trace.go:171","msg":"trace[756828640] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"112.498941ms","start":"2026-07-22T22:08:58.357882Z","end":"2026-07-22T22:08:58.470381Z","steps":["trace[756828640] 'process raft request'  (duration: 112.319966ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:08:58.582719Z","caller":"traceutil/trace.go:171","msg":"trace[964514991] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"105.106345ms","start":"2026-07-22T22:08:58.477581Z","end":"2026-07-22T22:08:58.582688Z","steps":["trace[964514991] 'process raft request'  (duration: 85.563853ms)","trace[964514991] 'compare'  (duration: 19.398858ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:09:52.989794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.996103ms","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-07-22T22:09:52.989896Z","caller":"traceutil/trace.go:171","msg":"trace[2005410879] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2622; }","duration":"170.135236ms","start":"2026-07-22T22:09:52.819742Z","end":"2026-07-22T22:09:52.989877Z","steps":["trace[2005410879] 'range keys from in-memory index tree'  (duration: 169.828518ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:10:27.750821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.568799ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249468114 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2822 > 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-07-22T22:10:27.751031Z","caller":"traceutil/trace.go:171","msg":"trace[2075711778] transaction","detail":"{read_only:false; response_revision:2832; number_of_response:1; }","duration":"207.606895ms","start":"2026-07-22T22:10:27.543408Z","end":"2026-07-22T22:10:27.751015Z","steps":["trace[2075711778] 'process raft request'  (duration: 207.550873ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:10:27.751065Z","caller":"traceutil/trace.go:171","msg":"trace[34355110] transaction","detail":"{read_only:false; response_revision:2831; number_of_response:1; }","duration":"242.38075ms","start":"2026-07-22T22:10:27.508652Z","end":"2026-07-22T22:10:27.751032Z","steps":["trace[34355110] 'process raft request'  (duration: 20.40191ms)","trace[34355110] 'compare'  (duration: 221.437705ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:10:27.989086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.83949ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249468116 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2824 > 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":"info","ts":"2026-07-22T22:10:27.989467Z","caller":"traceutil/trace.go:171","msg":"trace[1787490696] transaction","detail":"{read_only:false; response_revision:2833; number_of_response:1; }","duration":"360.335422ms","start":"2026-07-22T22:10:27.629098Z","end":"2026-07-22T22:10:27.989434Z","steps":["trace[1787490696] 'process raft request'  (duration: 239.06453ms)","trace[1787490696] 'compare'  (duration: 120.670396ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:10:27.989624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:10:27.62907Z","time spent":"360.472055ms","remote":"127.0.0.1:50602","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:2824 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-07-22T22:10:27.990506Z","caller":"traceutil/trace.go:171","msg":"trace[1702386802] transaction","detail":"{read_only:false; response_revision:2834; number_of_response:1; }","duration":"267.47937ms","start":"2026-07-22T22:10:27.722995Z","end":"2026-07-22T22:10:27.990474Z","steps":["trace[1702386802] 'process raft request'  (duration: 266.301258ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:10:27.990678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.993238ms","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-07-22T22:10:27.990739Z","caller":"traceutil/trace.go:171","msg":"trace[508481634] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2834; }","duration":"199.084901ms","start":"2026-07-22T22:10:27.791636Z","end":"2026-07-22T22:10:27.99072Z","steps":["trace[508481634] 'agreement among raft nodes before linearized reading'  (duration: 198.904676ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:10:27.991076Z","caller":"traceutil/trace.go:171","msg":"trace[1240785795] linearizableReadLoop","detail":"{readStateIndex:2947; appliedIndex:2945; }","duration":"198.749002ms","start":"2026-07-22T22:10:27.791674Z","end":"2026-07-22T22:10:27.990423Z","steps":["trace[1240785795] 'read index received'  (duration: 76.569404ms)","trace[1240785795] 'applied index is now lower than readState.Index'  (duration: 122.178708ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:14:24.079505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.416595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-hxqff.18c4bc5d71ca3e3d\" ","response":"range_response_count:1 size:962"}
{"level":"warn","ts":"2026-07-22T22:14:24.079556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.30951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4fd9b457-dae6-43f9-b7a8-763a731ec87a\" ","response":"range_response_count:1 size:3600"}
{"level":"info","ts":"2026-07-22T22:14:24.07962Z","caller":"traceutil/trace.go:171","msg":"trace[1320675731] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4fd9b457-dae6-43f9-b7a8-763a731ec87a; range_end:; response_count:1; response_revision:5001; }","duration":"181.419002ms","start":"2026-07-22T22:14:23.898187Z","end":"2026-07-22T22:14:24.079606Z","steps":["trace[1320675731] 'range keys from in-memory index tree'  (duration: 181.182856ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:14:24.079626Z","caller":"traceutil/trace.go:171","msg":"trace[1166468179] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-hxqff.18c4bc5d71ca3e3d; range_end:; response_count:1; response_revision:5001; }","duration":"180.560029ms","start":"2026-07-22T22:14:23.899039Z","end":"2026-07-22T22:14:24.079599Z","steps":["trace[1166468179] 'range keys from in-memory index tree'  (duration: 180.254831ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:14:36.753067Z","caller":"traceutil/trace.go:171","msg":"trace[1773211044] transaction","detail":"{read_only:false; response_revision:5264; number_of_response:1; }","duration":"120.01747ms","start":"2026-07-22T22:14:36.633021Z","end":"2026-07-22T22:14:36.753038Z","steps":["trace[1773211044] 'process raft request'  (duration: 45.057413ms)","trace[1773211044] 'compare'  (duration: 74.854664ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:14:37.191547Z","caller":"traceutil/trace.go:171","msg":"trace[1776089106] transaction","detail":"{read_only:false; response_revision:5266; number_of_response:1; }","duration":"154.383457ms","start":"2026-07-22T22:14:37.037142Z","end":"2026-07-22T22:14:37.191526Z","steps":["trace[1776089106] 'process raft request'  (duration: 154.256323ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:14:37.483886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.850958ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249474005 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/openstack/memcached-metrics-bsvc8\" mod_revision:5257 > success:<request_put:<key:\"/registry/endpointslices/openstack/memcached-metrics-bsvc8\" value_size:1001 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/memcached-metrics-bsvc8\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-22T22:14:37.484003Z","caller":"traceutil/trace.go:171","msg":"trace[1247002680] transaction","detail":"{read_only:false; response_revision:5267; number_of_response:1; }","duration":"285.828453ms","start":"2026-07-22T22:14:37.198153Z","end":"2026-07-22T22:14:37.483981Z","steps":["trace[1247002680] 'process raft request'  (duration: 129.781489ms)","trace[1247002680] 'compare'  (duration: 155.727245ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:14:37.523581Z","caller":"traceutil/trace.go:171","msg":"trace[1109507652] transaction","detail":"{read_only:false; response_revision:5268; number_of_response:1; }","duration":"325.371754ms","start":"2026-07-22T22:14:37.198185Z","end":"2026-07-22T22:14:37.523557Z","steps":["trace[1109507652] 'process raft request'  (duration: 325.191489ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:14:37.523741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:14:37.198157Z","time spent":"325.501758ms","remote":"127.0.0.1:50516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":529,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/memcached-metrics\" mod_revision:5258 > success:<request_put:<key:\"/registry/services/endpoints/openstack/memcached-metrics\" value_size:465 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/memcached-metrics\" > >"}
{"level":"info","ts":"2026-07-22T22:14:37.52386Z","caller":"traceutil/trace.go:171","msg":"trace[39721511] linearizableReadLoop","detail":"{readStateIndex:5471; appliedIndex:5467; }","duration":"312.715985ms","start":"2026-07-22T22:14:37.211122Z","end":"2026-07-22T22:14:37.523838Z","steps":["trace[39721511] 'read index received'  (duration: 116.824313ms)","trace[39721511] 'applied index is now lower than readState.Index'  (duration: 195.890722ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:14:37.523908Z","caller":"traceutil/trace.go:171","msg":"trace[866510728] transaction","detail":"{read_only:false; response_revision:5270; number_of_response:1; }","duration":"324.561812ms","start":"2026-07-22T22:14:37.199316Z","end":"2026-07-22T22:14:37.523878Z","steps":["trace[866510728] 'process raft request'  (duration: 324.444298ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:14:37.524041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.947152ms","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-07-22T22:14:37.524065Z","caller":"traceutil/trace.go:171","msg":"trace[1263270121] transaction","detail":"{read_only:false; response_revision:5269; number_of_response:1; }","duration":"325.5898ms","start":"2026-07-22T22:14:37.198449Z","end":"2026-07-22T22:14:37.524038Z","steps":["trace[1263270121] 'process raft request'  (duration: 325.068836ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:14:37.52408Z","caller":"traceutil/trace.go:171","msg":"trace[770701008] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5270; }","duration":"313.017864ms","start":"2026-07-22T22:14:37.211051Z","end":"2026-07-22T22:14:37.524069Z","steps":["trace[770701008] 'agreement among raft nodes before linearized reading'  (duration: 312.86497ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:14:37.524076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:14:37.199304Z","time spent":"324.677444ms","remote":"127.0.0.1:50610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1038,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/memcached-sjpsz\" mod_revision:5235 > success:<request_put:<key:\"/registry/endpointslices/openstack/memcached-sjpsz\" value_size:980 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/memcached-sjpsz\" > >"}
{"level":"warn","ts":"2026-07-22T22:14:37.524114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:14:37.211035Z","time spent":"313.070675ms","remote":"127.0.0.1:50602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-07-22T22:14:37.524143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:14:37.19844Z","time spent":"325.661552ms","remote":"127.0.0.1:50516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":681,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/memcached\" mod_revision:5236 > success:<request_put:<key:\"/registry/services/endpoints/openstack/memcached\" value_size:625 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/memcached\" > >"}
{"level":"info","ts":"2026-07-22T22:14:44.526499Z","caller":"traceutil/trace.go:171","msg":"trace[1773263216] linearizableReadLoop","detail":"{readStateIndex:5653; appliedIndex:5646; }","duration":"149.650288ms","start":"2026-07-22T22:14:44.376828Z","end":"2026-07-22T22:14:44.526478Z","steps":["trace[1773263216] 'read index received'  (duration: 3.498127ms)","trace[1773263216] 'applied index is now lower than readState.Index'  (duration: 146.151021ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:14:44.526555Z","caller":"traceutil/trace.go:171","msg":"trace[789675904] transaction","detail":"{read_only:false; response_revision:5449; number_of_response:1; }","duration":"154.978944ms","start":"2026-07-22T22:14:44.371539Z","end":"2026-07-22T22:14:44.526518Z","steps":["trace[789675904] 'process raft request'  (duration: 127.408624ms)","trace[789675904] 'compare'  (duration: 27.447027ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:14:44.526811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.971767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-07-22T22:14:44.526867Z","caller":"traceutil/trace.go:171","msg":"trace[2039729905] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5449; }","duration":"150.089819ms","start":"2026-07-22T22:14:44.376765Z","end":"2026-07-22T22:14:44.526855Z","steps":["trace[2039729905] 'agreement among raft nodes before linearized reading'  (duration: 149.852813ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:15:57.895303Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2998}
{"level":"info","ts":"2026-07-22T22:15:57.958298Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2998,"took":"61.9902ms","hash":3717518007,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":34258944,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-07-22T22:15:57.958374Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3717518007,"revision":2998,"compact-revision":-1}
{"level":"info","ts":"2026-07-22T22:20:46.120093Z","caller":"traceutil/trace.go:171","msg":"trace[1525517045] transaction","detail":"{read_only:false; response_revision:8234; number_of_response:1; }","duration":"104.509568ms","start":"2026-07-22T22:20:46.015561Z","end":"2026-07-22T22:20:46.120071Z","steps":["trace[1525517045] 'process raft request'  (duration: 104.382815ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:20:46.723139Z","caller":"traceutil/trace.go:171","msg":"trace[505847181] linearizableReadLoop","detail":"{readStateIndex:8527; appliedIndex:8526; }","duration":"218.276692ms","start":"2026-07-22T22:20:46.504844Z","end":"2026-07-22T22:20:46.72312Z","steps":["trace[505847181] 'read index received'  (duration: 218.098787ms)","trace[505847181] 'applied index is now lower than readState.Index'  (duration: 176.875µs)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:20:46.723197Z","caller":"traceutil/trace.go:171","msg":"trace[838068228] transaction","detail":"{read_only:false; response_revision:8237; number_of_response:1; }","duration":"223.93944ms","start":"2026-07-22T22:20:46.499226Z","end":"2026-07-22T22:20:46.723166Z","steps":["trace[838068228] 'process raft request'  (duration: 223.737784ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:20:46.723379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.51959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jgftl\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-07-22T22:20:46.723453Z","caller":"traceutil/trace.go:171","msg":"trace[1470429731] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jgftl; range_end:; response_count:1; response_revision:8237; }","duration":"218.647543ms","start":"2026-07-22T22:20:46.504788Z","end":"2026-07-22T22:20:46.723436Z","steps":["trace[1470429731] 'agreement among raft nodes before linearized reading'  (duration: 218.413857ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:20:47.582868Z","caller":"traceutil/trace.go:171","msg":"trace[1796732506] linearizableReadLoop","detail":"{readStateIndex:8530; appliedIndex:8529; }","duration":"116.660355ms","start":"2026-07-22T22:20:47.466186Z","end":"2026-07-22T22:20:47.582846Z","steps":["trace[1796732506] 'read index received'  (duration: 116.515481ms)","trace[1796732506] 'applied index is now lower than readState.Index'  (duration: 143.934µs)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:20:47.582975Z","caller":"traceutil/trace.go:171","msg":"trace[553136935] transaction","detail":"{read_only:false; response_revision:8240; number_of_response:1; }","duration":"255.630118ms","start":"2026-07-22T22:20:47.327337Z","end":"2026-07-22T22:20:47.582967Z","steps":["trace[553136935] 'process raft request'  (duration: 255.382082ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:20:47.583201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.014064ms","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-07-22T22:20:47.583231Z","caller":"traceutil/trace.go:171","msg":"trace[854840126] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8240; }","duration":"117.097488ms","start":"2026-07-22T22:20:47.466127Z","end":"2026-07-22T22:20:47.583224Z","steps":["trace[854840126] 'agreement among raft nodes before linearized reading'  (duration: 116.954784ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:20:47.583275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.358854ms","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-07-22T22:20:47.583341Z","caller":"traceutil/trace.go:171","msg":"trace[1553930581] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8240; }","duration":"104.466716ms","start":"2026-07-22T22:20:47.47886Z","end":"2026-07-22T22:20:47.583327Z","steps":["trace[1553930581] 'agreement among raft nodes before linearized reading'  (duration: 104.293642ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:20:48.256919Z","caller":"traceutil/trace.go:171","msg":"trace[966725801] transaction","detail":"{read_only:false; response_revision:8245; number_of_response:1; }","duration":"128.660077ms","start":"2026-07-22T22:20:48.128238Z","end":"2026-07-22T22:20:48.256898Z","steps":["trace[966725801] 'process raft request'  (duration: 128.518213ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:20:48.270427Z","caller":"traceutil/trace.go:171","msg":"trace[104320492] transaction","detail":"{read_only:false; response_revision:8246; number_of_response:1; }","duration":"137.38261ms","start":"2026-07-22T22:20:48.13303Z","end":"2026-07-22T22:20:48.270412Z","steps":["trace[104320492] 'process raft request'  (duration: 137.00378ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:20:57.901077Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6107}
{"level":"info","ts":"2026-07-22T22:20:57.999341Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6107,"took":"96.671921ms","hash":1874301164,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":23298048,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-07-22T22:20:57.99941Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1874301164,"revision":6107,"compact-revision":2998}
{"level":"info","ts":"2026-07-22T22:21:15.005857Z","caller":"traceutil/trace.go:171","msg":"trace[402275289] transaction","detail":"{read_only:false; response_revision:8443; number_of_response:1; }","duration":"158.552971ms","start":"2026-07-22T22:21:14.847278Z","end":"2026-07-22T22:21:15.005831Z","steps":["trace[402275289] 'process raft request'  (duration: 158.065368ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:21:15.198267Z","caller":"traceutil/trace.go:171","msg":"trace[1932063520] transaction","detail":"{read_only:false; response_revision:8444; number_of_response:1; }","duration":"186.712773ms","start":"2026-07-22T22:21:15.011516Z","end":"2026-07-22T22:21:15.198229Z","steps":["trace[1932063520] 'process raft request'  (duration: 186.505867ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:21:27.474054Z","caller":"traceutil/trace.go:171","msg":"trace[1156317909] transaction","detail":"{read_only:false; response_revision:8551; number_of_response:1; }","duration":"109.290015ms","start":"2026-07-22T22:21:27.364728Z","end":"2026-07-22T22:21:27.474018Z","steps":["trace[1156317909] 'process raft request'  (duration: 109.042238ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:21:28.444167Z","caller":"traceutil/trace.go:171","msg":"trace[737778610] transaction","detail":"{read_only:false; response_revision:8558; number_of_response:1; }","duration":"124.007332ms","start":"2026-07-22T22:21:28.320139Z","end":"2026-07-22T22:21:28.444146Z","steps":["trace[737778610] 'process raft request'  (duration: 123.756785ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:21:28.587048Z","caller":"traceutil/trace.go:171","msg":"trace[464221752] transaction","detail":"{read_only:false; response_revision:8561; number_of_response:1; }","duration":"119.390525ms","start":"2026-07-22T22:21:28.467639Z","end":"2026-07-22T22:21:28.587029Z","steps":["trace[464221752] 'process raft request'  (duration: 119.344023ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:21:28.58738Z","caller":"traceutil/trace.go:171","msg":"trace[2039871660] transaction","detail":"{read_only:false; response_revision:8560; number_of_response:1; }","duration":"120.223667ms","start":"2026-07-22T22:21:28.467145Z","end":"2026-07-22T22:21:28.587368Z","steps":["trace[2039871660] 'process raft request'  (duration: 29.621252ms)","trace[2039871660] 'compare'  (duration: 89.854654ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:22:15.450329Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000248f.wal"}
{"level":"info","ts":"2026-07-22T22:22:38.716686Z","caller":"traceutil/trace.go:171","msg":"trace[299100509] transaction","detail":"{read_only:false; response_revision:9211; number_of_response:1; }","duration":"103.359ms","start":"2026-07-22T22:22:38.613293Z","end":"2026-07-22T22:22:38.716652Z","steps":["trace[299100509] 'process raft request'  (duration: 103.042221ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:23:27.588999Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"51a5c416a4d98c86","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-22T22:23:27.598205Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-07-22T22:23:27.598312Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-07-22T22:25:57.909202Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8304}
{"level":"info","ts":"2026-07-22T22:25:57.991296Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8304,"took":"79.464109ms","hash":826601336,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":27017216,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-07-22T22:25:57.991369Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":826601336,"revision":8304,"compact-revision":6107}
{"level":"info","ts":"2026-07-22T22:26:15.314309Z","caller":"traceutil/trace.go:171","msg":"trace[1566113831] transaction","detail":"{read_only:false; response_revision:11121; number_of_response:1; }","duration":"174.087179ms","start":"2026-07-22T22:26:15.140169Z","end":"2026-07-22T22:26:15.314256Z","steps":["trace[1566113831] 'process raft request'  (duration: 107.528749ms)","trace[1566113831] 'compare'  (duration: 66.419996ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:26:15.314344Z","caller":"traceutil/trace.go:171","msg":"trace[2116894498] transaction","detail":"{read_only:false; response_revision:11122; number_of_response:1; }","duration":"167.97388ms","start":"2026-07-22T22:26:15.146342Z","end":"2026-07-22T22:26:15.314315Z","steps":["trace[2116894498] 'process raft request'  (duration: 167.905178ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:26:15.314625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.786573ms","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-07-22T22:26:15.314681Z","caller":"traceutil/trace.go:171","msg":"trace[1287160211] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11122; }","duration":"199.881386ms","start":"2026-07-22T22:26:15.114787Z","end":"2026-07-22T22:26:15.314669Z","steps":["trace[1287160211] 'agreement among raft nodes before linearized reading'  (duration: 199.701641ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:26:15.314432Z","caller":"traceutil/trace.go:171","msg":"trace[1379905938] linearizableReadLoop","detail":"{readStateIndex:11500; appliedIndex:11499; }","duration":"172.424083ms","start":"2026-07-22T22:26:15.141977Z","end":"2026-07-22T22:26:15.314401Z","steps":["trace[1379905938] 'read index received'  (duration: 105.740129ms)","trace[1379905938] 'applied index is now lower than readState.Index'  (duration: 66.680024ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:26:15.516928Z","caller":"traceutil/trace.go:171","msg":"trace[323292281] transaction","detail":"{read_only:false; response_revision:11124; number_of_response:1; }","duration":"125.070597ms","start":"2026-07-22T22:26:15.391827Z","end":"2026-07-22T22:26:15.516898Z","steps":["trace[323292281] 'process raft request'  (duration: 108.916728ms)","trace[323292281] 'compare'  (duration: 15.931092ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:30:57.915797Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":11025}
{"level":"info","ts":"2026-07-22T22:30:57.991474Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":11025,"took":"73.280448ms","hash":1719986437,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":28299264,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-07-22T22:30:57.991532Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1719986437,"revision":11025,"compact-revision":8304}
{"level":"info","ts":"2026-07-22T22:32:26.415541Z","caller":"traceutil/trace.go:171","msg":"trace[1694092445] transaction","detail":"{read_only:false; response_revision:13628; number_of_response:1; }","duration":"103.750275ms","start":"2026-07-22T22:32:26.311762Z","end":"2026-07-22T22:32:26.415512Z","steps":["trace[1694092445] 'process raft request'  (duration: 103.503338ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:32:33.626036Z","caller":"traceutil/trace.go:171","msg":"trace[515822263] transaction","detail":"{read_only:false; response_revision:13682; number_of_response:1; }","duration":"103.697743ms","start":"2026-07-22T22:32:33.522312Z","end":"2026-07-22T22:32:33.626009Z","steps":["trace[515822263] 'process raft request'  (duration: 103.541529ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:32:43.17902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.754106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-07-22T22:32:43.179091Z","caller":"traceutil/trace.go:171","msg":"trace[1181546684] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:13841; }","duration":"326.852529ms","start":"2026-07-22T22:32:42.852224Z","end":"2026-07-22T22:32:43.179077Z","steps":["trace[1181546684] 'count revisions from in-memory index tree'  (duration: 326.671584ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:32:43.179163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:32:42.852172Z","time spent":"326.957462ms","remote":"127.0.0.1:54734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-07-22T22:32:43.179134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.512991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d26d553f-0879-4777-8ea4-c9485e2643ed\" ","response":"range_response_count:1 size:3606"}
{"level":"info","ts":"2026-07-22T22:32:43.17922Z","caller":"traceutil/trace.go:171","msg":"trace[1095349444] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d26d553f-0879-4777-8ea4-c9485e2643ed; range_end:; response_count:1; response_revision:13841; }","duration":"384.673386ms","start":"2026-07-22T22:32:42.794524Z","end":"2026-07-22T22:32:43.179197Z","steps":["trace[1095349444] 'range keys from in-memory index tree'  (duration: 384.284975ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:32:43.179225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.741847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a3fe83aa-e659-46b1-a080-4fc04f97c4c7\" ","response":"range_response_count:1 size:3606"}
{"level":"warn","ts":"2026-07-22T22:32:43.179273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:32:42.794515Z","time spent":"384.747578ms","remote":"127.0.0.1:50528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3629,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d26d553f-0879-4777-8ea4-c9485e2643ed\" "}
{"level":"info","ts":"2026-07-22T22:32:43.179317Z","caller":"traceutil/trace.go:171","msg":"trace[561058242] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a3fe83aa-e659-46b1-a080-4fc04f97c4c7; range_end:; response_count:1; response_revision:13841; }","duration":"389.895772ms","start":"2026-07-22T22:32:42.789402Z","end":"2026-07-22T22:32:43.179297Z","steps":["trace[561058242] 'range keys from in-memory index tree'  (duration: 389.516461ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:32:43.179372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:32:42.789362Z","time spent":"390.000365ms","remote":"127.0.0.1:50528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3629,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a3fe83aa-e659-46b1-a080-4fc04f97c4c7\" "}
{"level":"warn","ts":"2026-07-22T22:32:43.179676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.872842ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249497547 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:13733 > 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":"info","ts":"2026-07-22T22:32:43.180013Z","caller":"traceutil/trace.go:171","msg":"trace[2005429748] linearizableReadLoop","detail":"{readStateIndex:14315; appliedIndex:14314; }","duration":"151.952375ms","start":"2026-07-22T22:32:43.028039Z","end":"2026-07-22T22:32:43.179991Z","steps":["trace[2005429748] 'read index received'  (duration: 17.61165ms)","trace[2005429748] 'applied index is now lower than readState.Index'  (duration: 134.338275ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:32:43.180233Z","caller":"traceutil/trace.go:171","msg":"trace[1377226175] transaction","detail":"{read_only:false; response_revision:13842; number_of_response:1; }","duration":"294.821538ms","start":"2026-07-22T22:32:42.885368Z","end":"2026-07-22T22:32:43.18019Z","steps":["trace[1377226175] 'process raft request'  (duration: 160.350999ms)","trace[1377226175] 'compare'  (duration: 133.359898ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:32:43.180326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.274464ms","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-07-22T22:32:43.180413Z","caller":"traceutil/trace.go:171","msg":"trace[734976945] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:13842; }","duration":"152.396118ms","start":"2026-07-22T22:32:43.028Z","end":"2026-07-22T22:32:43.180396Z","steps":["trace[734976945] 'agreement among raft nodes before linearized reading'  (duration: 152.215773ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:34:26.065663Z","caller":"traceutil/trace.go:171","msg":"trace[1543809919] transaction","detail":"{read_only:false; response_revision:14948; number_of_response:1; }","duration":"149.368273ms","start":"2026-07-22T22:34:25.916264Z","end":"2026-07-22T22:34:26.065633Z","steps":["trace[1543809919] 'process raft request'  (duration: 149.139427ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:35:57.922144Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13063}
{"level":"info","ts":"2026-07-22T22:35:57.995024Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13063,"took":"70.121549ms","hash":2503964244,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":31404032,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-07-22T22:35:57.99508Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2503964244,"revision":13063,"compact-revision":11025}
{"level":"info","ts":"2026-07-22T22:40:06.907952Z","caller":"traceutil/trace.go:171","msg":"trace[254070165] linearizableReadLoop","detail":"{readStateIndex:18308; appliedIndex:18307; }","duration":"201.081621ms","start":"2026-07-22T22:40:06.706853Z","end":"2026-07-22T22:40:06.907934Z","steps":["trace[254070165] 'read index received'  (duration: 200.872325ms)","trace[254070165] 'applied index is now lower than readState.Index'  (duration: 206.236µs)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:40:06.908063Z","caller":"traceutil/trace.go:171","msg":"trace[1440533731] transaction","detail":"{read_only:false; response_revision:17714; number_of_response:1; }","duration":"208.519628ms","start":"2026-07-22T22:40:06.699537Z","end":"2026-07-22T22:40:06.908056Z","steps":["trace[1440533731] 'process raft request'  (duration: 208.291952ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:40:06.908269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.398729ms","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:6"}
{"level":"info","ts":"2026-07-22T22:40:06.908293Z","caller":"traceutil/trace.go:171","msg":"trace[268006849] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:17714; }","duration":"201.472292ms","start":"2026-07-22T22:40:06.706814Z","end":"2026-07-22T22:40:06.908287Z","steps":["trace[268006849] 'agreement among raft nodes before linearized reading'  (duration: 201.41595ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:40:06.908434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.062944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-07-22T22:40:06.908452Z","caller":"traceutil/trace.go:171","msg":"trace[1661168895] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17714; }","duration":"177.111604ms","start":"2026-07-22T22:40:06.731336Z","end":"2026-07-22T22:40:06.908447Z","steps":["trace[1661168895] 'agreement among raft nodes before linearized reading'  (duration: 177.042352ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:40:07.23475Z","caller":"traceutil/trace.go:171","msg":"trace[312156948] transaction","detail":"{read_only:false; response_revision:17715; number_of_response:1; }","duration":"322.436644ms","start":"2026-07-22T22:40:06.912279Z","end":"2026-07-22T22:40:07.234716Z","steps":["trace[312156948] 'process raft request'  (duration: 252.199151ms)","trace[312156948] 'compare'  (duration: 69.964866ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:40:07.234913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:40:06.912259Z","time spent":"322.575729ms","remote":"127.0.0.1:50602","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:17700 > 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":"info","ts":"2026-07-22T22:40:07.255956Z","caller":"traceutil/trace.go:171","msg":"trace[1277512241] linearizableReadLoop","detail":"{readStateIndex:18310; appliedIndex:18308; }","duration":"314.555375ms","start":"2026-07-22T22:40:06.941373Z","end":"2026-07-22T22:40:07.255928Z","steps":["trace[1277512241] 'read index received'  (duration: 223.295538ms)","trace[1277512241] 'applied index is now lower than readState.Index'  (duration: 91.258617ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:40:07.256451Z","caller":"traceutil/trace.go:171","msg":"trace[2032434764] transaction","detail":"{read_only:false; response_revision:17716; number_of_response:1; }","duration":"333.474801ms","start":"2026-07-22T22:40:06.922962Z","end":"2026-07-22T22:40:07.256437Z","steps":["trace[2032434764] 'process raft request'  (duration: 332.812193ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:40:07.256649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:40:06.922948Z","time spent":"333.595985ms","remote":"127.0.0.1:50528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20867,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/libvirt-libvirt-default-pcj4t\" mod_revision:17601 > success:<request_put:<key:\"/registry/pods/openstack/libvirt-libvirt-default-pcj4t\" value_size:20803 >> failure:<request_range:<key:\"/registry/pods/openstack/libvirt-libvirt-default-pcj4t\" > >"}
{"level":"warn","ts":"2026-07-22T22:40:07.256793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.909056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-endpoints\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:40:07.256828Z","caller":"traceutil/trace.go:171","msg":"trace[999113343] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-endpoints; range_end:; response_count:0; response_revision:17716; }","duration":"314.971427ms","start":"2026-07-22T22:40:06.941848Z","end":"2026-07-22T22:40:07.25682Z","steps":["trace[999113343] 'agreement among raft nodes before linearized reading'  (duration: 314.906145ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:40:07.256849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:40:06.941837Z","time spent":"315.008358ms","remote":"127.0.0.1:50584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/heat-ks-endpoints\" "}
{"level":"warn","ts":"2026-07-22T22:40:07.256967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.594835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:40:07.256987Z","caller":"traceutil/trace.go:171","msg":"trace[1572354594] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-user; range_end:; response_count:0; response_revision:17716; }","duration":"315.642745ms","start":"2026-07-22T22:40:06.941339Z","end":"2026-07-22T22:40:07.256982Z","steps":["trace[1572354594] 'agreement among raft nodes before linearized reading'  (duration: 315.609254ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:40:07.257005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:40:06.941327Z","time spent":"315.673287ms","remote":"127.0.0.1:50584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/heat-ks-user\" "}
{"level":"warn","ts":"2026-07-22T22:40:07.257458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.565188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:40:07.257528Z","caller":"traceutil/trace.go:171","msg":"trace[1097255920] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-user; range_end:; response_count:0; response_revision:17716; }","duration":"231.681431ms","start":"2026-07-22T22:40:07.025837Z","end":"2026-07-22T22:40:07.257518Z","steps":["trace[1097255920] 'agreement among raft nodes before linearized reading'  (duration: 231.589769ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:40:07.257563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.564558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:40:07.257586Z","caller":"traceutil/trace.go:171","msg":"trace[1627858468] range","detail":"{range_begin:/registry/jobs/openstack/heat-rabbit-init; range_end:; response_count:0; response_revision:17716; }","duration":"313.608609ms","start":"2026-07-22T22:40:06.943971Z","end":"2026-07-22T22:40:07.257579Z","steps":["trace[1627858468] 'agreement among raft nodes before linearized reading'  (duration: 313.578458ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:40:07.257602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:40:06.943959Z","time spent":"313.63935ms","remote":"127.0.0.1:50584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/heat-rabbit-init\" "}
{"level":"warn","ts":"2026-07-22T22:40:07.257704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.421592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-domain-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:40:07.257726Z","caller":"traceutil/trace.go:171","msg":"trace[68724709] range","detail":"{range_begin:/registry/jobs/openstack/heat-domain-ks-user; range_end:; response_count:0; response_revision:17716; }","duration":"314.464923ms","start":"2026-07-22T22:40:06.943253Z","end":"2026-07-22T22:40:07.257718Z","steps":["trace[68724709] 'agreement among raft nodes before linearized reading'  (duration: 314.434922ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:40:07.257743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:40:06.943241Z","time spent":"314.496154ms","remote":"127.0.0.1:50584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/heat-domain-ks-user\" "}
{"level":"warn","ts":"2026-07-22T22:40:07.257797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.44541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-bootstrap\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:40:07.257814Z","caller":"traceutil/trace.go:171","msg":"trace[249659895] range","detail":"{range_begin:/registry/jobs/openstack/heat-bootstrap; range_end:; response_count:0; response_revision:17716; }","duration":"315.512622ms","start":"2026-07-22T22:40:06.942296Z","end":"2026-07-22T22:40:07.257809Z","steps":["trace[249659895] 'agreement among raft nodes before linearized reading'  (duration: 315.488471ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:40:07.257829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:40:06.942287Z","time spent":"315.537933ms","remote":"127.0.0.1:50584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/heat-bootstrap\" "}
{"level":"warn","ts":"2026-07-22T22:40:07.257914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.944108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-bootstrap\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:40:07.257934Z","caller":"traceutil/trace.go:171","msg":"trace[186610116] range","detail":"{range_begin:/registry/jobs/openstack/heat-bootstrap; range_end:; response_count:0; response_revision:17716; }","duration":"231.978859ms","start":"2026-07-22T22:40:07.025949Z","end":"2026-07-22T22:40:07.257927Z","steps":["trace[186610116] 'agreement among raft nodes before linearized reading'  (duration: 231.952959ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:40:07.257988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.089581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:40:07.258018Z","caller":"traceutil/trace.go:171","msg":"trace[274097398] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17716; }","duration":"119.161913ms","start":"2026-07-22T22:40:07.138838Z","end":"2026-07-22T22:40:07.258Z","steps":["trace[274097398] 'agreement among raft nodes before linearized reading'  (duration: 119.136573ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:40:07.258115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.180695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-domain-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-22T22:40:07.258158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.74446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:40:07.258181Z","caller":"traceutil/trace.go:171","msg":"trace[635940087] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-user; range_end:; response_count:0; response_revision:17716; }","duration":"137.792171ms","start":"2026-07-22T22:40:07.120383Z","end":"2026-07-22T22:40:07.258175Z","steps":["trace[635940087] 'agreement among raft nodes before linearized reading'  (duration: 137.763941ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:40:07.258218Z","caller":"traceutil/trace.go:171","msg":"trace[394451430] range","detail":"{range_begin:/registry/jobs/openstack/heat-domain-ks-user; range_end:; response_count:0; response_revision:17716; }","duration":"232.277108ms","start":"2026-07-22T22:40:07.025893Z","end":"2026-07-22T22:40:07.258171Z","steps":["trace[394451430] 'agreement among raft nodes before linearized reading'  (duration: 232.198226ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:40:07.258268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.069399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-domain-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:40:07.258287Z","caller":"traceutil/trace.go:171","msg":"trace[191775521] range","detail":"{range_begin:/registry/jobs/openstack/heat-domain-ks-user; range_end:; response_count:0; response_revision:17716; }","duration":"138.12827ms","start":"2026-07-22T22:40:07.120154Z","end":"2026-07-22T22:40:07.258282Z","steps":["trace[191775521] 'agreement among raft nodes before linearized reading'  (duration: 138.10078ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:40:07.25836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.274792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-endpoints\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:40:07.258378Z","caller":"traceutil/trace.go:171","msg":"trace[1163432359] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-endpoints; range_end:; response_count:0; response_revision:17716; }","duration":"139.322924ms","start":"2026-07-22T22:40:07.11905Z","end":"2026-07-22T22:40:07.258373Z","steps":["trace[1163432359] 'agreement among raft nodes before linearized reading'  (duration: 139.296633ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:40:07.258503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.608827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-endpoints\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:40:07.258566Z","caller":"traceutil/trace.go:171","msg":"trace[208948341] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-endpoints; range_end:; response_count:0; response_revision:17716; }","duration":"232.70238ms","start":"2026-07-22T22:40:07.025847Z","end":"2026-07-22T22:40:07.25855Z","steps":["trace[208948341] 'agreement among raft nodes before linearized reading'  (duration: 232.613617ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:40:07.258136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.602916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-db-sync\" ","response":"range_response_count:1 size:5032"}
{"level":"info","ts":"2026-07-22T22:40:07.260403Z","caller":"traceutil/trace.go:171","msg":"trace[1471315876] range","detail":"{range_begin:/registry/jobs/openstack/heat-db-sync; range_end:; response_count:1; response_revision:17716; }","duration":"139.875309ms","start":"2026-07-22T22:40:07.120516Z","end":"2026-07-22T22:40:07.260391Z","steps":["trace[1471315876] 'agreement among raft nodes before linearized reading'  (duration: 137.583165ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:40:07.257539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.166942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-db-sync\" ","response":"range_response_count:1 size:5032"}
{"level":"info","ts":"2026-07-22T22:40:07.260569Z","caller":"traceutil/trace.go:171","msg":"trace[683868393] range","detail":"{range_begin:/registry/jobs/openstack/heat-db-sync; range_end:; response_count:1; response_revision:17716; }","duration":"314.207426ms","start":"2026-07-22T22:40:06.94635Z","end":"2026-07-22T22:40:07.260557Z","steps":["trace[683868393] 'agreement among raft nodes before linearized reading'  (duration: 311.14778ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:40:07.26064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:40:06.94634Z","time spent":"314.274208ms","remote":"127.0.0.1:50584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5055,"request content":"key:\"/registry/jobs/openstack/heat-db-sync\" "}
{"level":"warn","ts":"2026-07-22T22:40:07.258455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.608611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-db-sync\" ","response":"range_response_count:1 size:5032"}
{"level":"warn","ts":"2026-07-22T22:40:07.257482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.63322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:40:07.260725Z","caller":"traceutil/trace.go:171","msg":"trace[965284644] range","detail":"{range_begin:/registry/jobs/openstack/heat-rabbit-init; range_end:; response_count:0; response_revision:17716; }","duration":"234.908491ms","start":"2026-07-22T22:40:07.025808Z","end":"2026-07-22T22:40:07.260716Z","steps":["trace[965284644] 'agreement among raft nodes before linearized reading'  (duration: 231.656881ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:40:07.260933Z","caller":"traceutil/trace.go:171","msg":"trace[1592135097] range","detail":"{range_begin:/registry/jobs/openstack/heat-db-sync; range_end:; response_count:1; response_revision:17716; }","duration":"233.102941ms","start":"2026-07-22T22:40:07.027822Z","end":"2026-07-22T22:40:07.260924Z","steps":["trace[1592135097] 'agreement among raft nodes before linearized reading'  (duration: 230.595111ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:40:18.294512Z","caller":"traceutil/trace.go:171","msg":"trace[566687260] transaction","detail":"{read_only:false; response_revision:17867; number_of_response:1; }","duration":"109.534826ms","start":"2026-07-22T22:40:18.184953Z","end":"2026-07-22T22:40:18.294488Z","steps":["trace[566687260] 'process raft request'  (duration: 109.408382ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:40:57.929516Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15558}
{"level":"info","ts":"2026-07-22T22:40:58.030597Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15558,"took":"97.536882ms","hash":3331374927,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":33681408,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-07-22T22:40:58.03067Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3331374927,"revision":15558,"compact-revision":13063}
{"level":"info","ts":"2026-07-22T22:43:32.634881Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"51a5c416a4d98c86","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-22T22:43:32.639479Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-07-22T22:43:32.639552Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-07-22T22:44:29.937759Z","caller":"traceutil/trace.go:171","msg":"trace[290944006] transaction","detail":"{read_only:false; response_revision:19664; number_of_response:1; }","duration":"130.912199ms","start":"2026-07-22T22:44:29.806825Z","end":"2026-07-22T22:44:29.937737Z","steps":["trace[290944006] 'process raft request'  (duration: 130.370824ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:44:30.744863Z","caller":"traceutil/trace.go:171","msg":"trace[927696410] linearizableReadLoop","detail":"{readStateIndex:20326; appliedIndex:20325; }","duration":"132.797482ms","start":"2026-07-22T22:44:30.61204Z","end":"2026-07-22T22:44:30.744837Z","steps":["trace[927696410] 'read index received'  (duration: 132.644728ms)","trace[927696410] 'applied index is now lower than readState.Index'  (duration: 151.694µs)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:44:30.7449Z","caller":"traceutil/trace.go:171","msg":"trace[1561288432] transaction","detail":"{read_only:false; response_revision:19665; number_of_response:1; }","duration":"142.316897ms","start":"2026-07-22T22:44:30.60256Z","end":"2026-07-22T22:44:30.744877Z","steps":["trace[1561288432] 'process raft request'  (duration: 142.121551ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:44:30.745152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.08948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-07-22T22:44:30.745227Z","caller":"traceutil/trace.go:171","msg":"trace[430239567] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:19665; }","duration":"133.196863ms","start":"2026-07-22T22:44:30.612013Z","end":"2026-07-22T22:44:30.74521Z","steps":["trace[430239567] 'agreement among raft nodes before linearized reading'  (duration: 133.001287ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:44:30.745207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.371009ms","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-07-22T22:44:30.745307Z","caller":"traceutil/trace.go:171","msg":"trace[75303923] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:19665; }","duration":"128.494692ms","start":"2026-07-22T22:44:30.616791Z","end":"2026-07-22T22:44:30.745286Z","steps":["trace[75303923] 'agreement among raft nodes before linearized reading'  (duration: 128.236245ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:44:31.001712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.473884ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249517039 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:19656 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-22T22:44:31.001844Z","caller":"traceutil/trace.go:171","msg":"trace[1690968564] transaction","detail":"{read_only:false; response_revision:19666; number_of_response:1; }","duration":"252.404057ms","start":"2026-07-22T22:44:30.749414Z","end":"2026-07-22T22:44:31.001818Z","steps":["trace[1690968564] 'process raft request'  (duration: 115.704016ms)","trace[1690968564] 'compare'  (duration: 135.972281ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:44:31.014129Z","caller":"traceutil/trace.go:171","msg":"trace[1025456290] transaction","detail":"{read_only:false; response_revision:19667; number_of_response:1; }","duration":"263.648109ms","start":"2026-07-22T22:44:30.750459Z","end":"2026-07-22T22:44:31.014107Z","steps":["trace[1025456290] 'process raft request'  (duration: 263.041922ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:44:31.2379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.054664ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249517043 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:0c869f8bdd3301f2>","response":"size:41"}
{"level":"info","ts":"2026-07-22T22:44:31.237996Z","caller":"traceutil/trace.go:171","msg":"trace[645995558] linearizableReadLoop","detail":"{readStateIndex:20329; appliedIndex:20328; }","duration":"128.452571ms","start":"2026-07-22T22:44:31.109527Z","end":"2026-07-22T22:44:31.237979Z","steps":["trace[645995558] 'read index received'  (duration: 44.801µs)","trace[645995558] 'applied index is now lower than readState.Index'  (duration: 128.40648ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:44:31.238194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.665417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-07-22T22:44:31.238232Z","caller":"traceutil/trace.go:171","msg":"trace[915459036] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:19667; }","duration":"128.748659ms","start":"2026-07-22T22:44:31.109474Z","end":"2026-07-22T22:44:31.238222Z","steps":["trace[915459036] 'agreement among raft nodes before linearized reading'  (duration: 128.587334ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:44:31.246965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.924051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:44:31.247016Z","caller":"traceutil/trace.go:171","msg":"trace[312628372] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19669; }","duration":"108.026323ms","start":"2026-07-22T22:44:31.138977Z","end":"2026-07-22T22:44:31.247004Z","steps":["trace[312628372] 'agreement among raft nodes before linearized reading'  (duration: 107.891169ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:44:31.524383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.403625ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249517047 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:19658 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-22T22:44:31.524542Z","caller":"traceutil/trace.go:171","msg":"trace[1646696526] transaction","detail":"{read_only:false; response_revision:19670; number_of_response:1; }","duration":"281.025313ms","start":"2026-07-22T22:44:31.243494Z","end":"2026-07-22T22:44:31.524519Z","steps":["trace[1646696526] 'process raft request'  (duration: 136.395572ms)","trace[1646696526] 'compare'  (duration: 144.275731ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:44:31.524679Z","caller":"traceutil/trace.go:171","msg":"trace[1678723024] transaction","detail":"{read_only:false; response_revision:19671; number_of_response:1; }","duration":"281.135555ms","start":"2026-07-22T22:44:31.243533Z","end":"2026-07-22T22:44:31.524669Z","steps":["trace[1678723024] 'process raft request'  (duration: 280.94563ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:44:31.524677Z","caller":"traceutil/trace.go:171","msg":"trace[1157050402] linearizableReadLoop","detail":"{readStateIndex:20333; appliedIndex:20331; }","duration":"276.478967ms","start":"2026-07-22T22:44:31.248173Z","end":"2026-07-22T22:44:31.524652Z","steps":["trace[1157050402] 'read index received'  (duration: 131.691652ms)","trace[1157050402] 'applied index is now lower than readState.Index'  (duration: 144.785705ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:44:31.524912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.721213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:44:31.524989Z","caller":"traceutil/trace.go:171","msg":"trace[217059084] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19671; }","duration":"276.833967ms","start":"2026-07-22T22:44:31.248138Z","end":"2026-07-22T22:44:31.524972Z","steps":["trace[217059084] 'agreement among raft nodes before linearized reading'  (duration: 276.624651ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:44:31.603189Z","caller":"traceutil/trace.go:171","msg":"trace[1483932490] transaction","detail":"{read_only:false; response_revision:19672; number_of_response:1; }","duration":"352.733486ms","start":"2026-07-22T22:44:31.25042Z","end":"2026-07-22T22:44:31.603153Z","steps":["trace[1483932490] 'process raft request'  (duration: 352.486599ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:44:31.603365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:44:31.250401Z","time spent":"352.87086ms","remote":"127.0.0.1:50602","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:19662 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-07-22T22:44:31.6035Z","caller":"traceutil/trace.go:171","msg":"trace[257619351] transaction","detail":"{read_only:false; response_revision:19673; number_of_response:1; }","duration":"352.891281ms","start":"2026-07-22T22:44:31.250566Z","end":"2026-07-22T22:44:31.603457Z","steps":["trace[257619351] 'process raft request'  (duration: 352.50938ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:44:31.604486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:44:31.250558Z","time spent":"353.859117ms","remote":"127.0.0.1:50602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:19661 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:367 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-07-22T22:44:31.604915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.641527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"}
{"level":"info","ts":"2026-07-22T22:44:31.604965Z","caller":"traceutil/trace.go:171","msg":"trace[1541023598] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:19673; }","duration":"346.693588ms","start":"2026-07-22T22:44:31.258247Z","end":"2026-07-22T22:44:31.604941Z","steps":["trace[1541023598] 'agreement among raft nodes before linearized reading'  (duration: 345.195506ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:44:31.604988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:44:31.258238Z","time spent":"346.74369ms","remote":"127.0.0.1:50602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":584,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "}
{"level":"info","ts":"2026-07-22T22:44:31.749081Z","caller":"traceutil/trace.go:171","msg":"trace[1127490789] linearizableReadLoop","detail":"{readStateIndex:20336; appliedIndex:20335; }","duration":"135.280601ms","start":"2026-07-22T22:44:31.613764Z","end":"2026-07-22T22:44:31.749044Z","steps":["trace[1127490789] 'read index received'  (duration: 57.086007ms)","trace[1127490789] 'applied index is now lower than readState.Index'  (duration: 78.193324ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:44:31.749155Z","caller":"traceutil/trace.go:171","msg":"trace[2035645756] transaction","detail":"{read_only:false; response_revision:19674; number_of_response:1; }","duration":"135.786305ms","start":"2026-07-22T22:44:31.613325Z","end":"2026-07-22T22:44:31.749111Z","steps":["trace[2035645756] 'process raft request'  (duration: 57.55733ms)","trace[2035645756] 'compare'  (duration: 78.014449ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:44:31.749547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.757424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-07-22T22:44:31.749615Z","caller":"traceutil/trace.go:171","msg":"trace[791378109] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:19674; }","duration":"135.905838ms","start":"2026-07-22T22:44:31.613692Z","end":"2026-07-22T22:44:31.749598Z","steps":["trace[791378109] 'agreement among raft nodes before linearized reading'  (duration: 135.466676ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:45:57.939082Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18166}
{"level":"info","ts":"2026-07-22T22:45:58.052741Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18166,"took":"109.461493ms","hash":4199725093,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":30920704,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-07-22T22:45:58.05279Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4199725093,"revision":18166,"compact-revision":15558}
{"level":"info","ts":"2026-07-22T22:50:57.945508Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20466}
{"level":"info","ts":"2026-07-22T22:50:58.051603Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20466,"took":"102.889281ms","hash":4026619532,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":44859392,"current-db-size-in-use":"45 MB"}
{"level":"info","ts":"2026-07-22T22:50:58.051665Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4026619532,"revision":20466,"compact-revision":18166}
{"level":"info","ts":"2026-07-22T22:51:18.634869Z","caller":"traceutil/trace.go:171","msg":"trace[230259197] transaction","detail":"{read_only:false; response_revision:23984; number_of_response:1; }","duration":"121.085167ms","start":"2026-07-22T22:51:18.513752Z","end":"2026-07-22T22:51:18.634837Z","steps":["trace[230259197] 'process raft request'  (duration: 120.781549ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:18.917088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.362983ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249528694 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:23968 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-22T22:51:18.9172Z","caller":"traceutil/trace.go:171","msg":"trace[839809656] transaction","detail":"{read_only:false; response_revision:23985; number_of_response:1; }","duration":"276.668463ms","start":"2026-07-22T22:51:18.640509Z","end":"2026-07-22T22:51:18.917178Z","steps":["trace[839809656] 'process raft request'  (duration: 154.135636ms)","trace[839809656] 'compare'  (duration: 122.206027ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:51:18.9294Z","caller":"traceutil/trace.go:171","msg":"trace[604892658] transaction","detail":"{read_only:false; response_revision:23986; number_of_response:1; }","duration":"249.23918ms","start":"2026-07-22T22:51:18.680111Z","end":"2026-07-22T22:51:18.929351Z","steps":["trace[604892658] 'process raft request'  (duration: 249.087696ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:18.929644Z","caller":"traceutil/trace.go:171","msg":"trace[1355222085] transaction","detail":"{read_only:false; response_revision:23987; number_of_response:1; }","duration":"244.337593ms","start":"2026-07-22T22:51:18.685279Z","end":"2026-07-22T22:51:18.929617Z","steps":["trace[1355222085] 'process raft request'  (duration: 244.037625ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:18.929831Z","caller":"traceutil/trace.go:171","msg":"trace[1807374445] transaction","detail":"{read_only:false; response_revision:23988; number_of_response:1; }","duration":"242.816932ms","start":"2026-07-22T22:51:18.686997Z","end":"2026-07-22T22:51:18.929814Z","steps":["trace[1807374445] 'process raft request'  (duration: 242.552204ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:18.929927Z","caller":"traceutil/trace.go:171","msg":"trace[364828593] linearizableReadLoop","detail":"{readStateIndex:24772; appliedIndex:24767; }","duration":"151.197774ms","start":"2026-07-22T22:51:18.778717Z","end":"2026-07-22T22:51:18.929915Z","steps":["trace[364828593] 'read index received'  (duration: 15.929193ms)","trace[364828593] 'applied index is now lower than readState.Index'  (duration: 135.267681ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:51:18.930014Z","caller":"traceutil/trace.go:171","msg":"trace[1707590436] transaction","detail":"{read_only:false; response_revision:23989; number_of_response:1; }","duration":"204.243459ms","start":"2026-07-22T22:51:18.725762Z","end":"2026-07-22T22:51:18.930005Z","steps":["trace[1707590436] 'process raft request'  (duration: 204.013283ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:18.930149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.430461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-07-22T22:51:18.930191Z","caller":"traceutil/trace.go:171","msg":"trace[221023854] transaction","detail":"{read_only:false; response_revision:23990; number_of_response:1; }","duration":"139.263072ms","start":"2026-07-22T22:51:18.790916Z","end":"2026-07-22T22:51:18.930179Z","steps":["trace[221023854] 'process raft request'  (duration: 138.951823ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:18.930219Z","caller":"traceutil/trace.go:171","msg":"trace[91556947] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23990; }","duration":"151.522523ms","start":"2026-07-22T22:51:18.778665Z","end":"2026-07-22T22:51:18.930187Z","steps":["trace[91556947] 'agreement among raft nodes before linearized reading'  (duration: 151.39513ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:19.072611Z","caller":"traceutil/trace.go:171","msg":"trace[1940362384] transaction","detail":"{read_only:false; response_revision:23991; number_of_response:1; }","duration":"138.426569ms","start":"2026-07-22T22:51:18.934161Z","end":"2026-07-22T22:51:19.072588Z","steps":["trace[1940362384] 'process raft request'  (duration: 138.274804ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:19.120836Z","caller":"traceutil/trace.go:171","msg":"trace[1206733585] transaction","detail":"{read_only:false; response_revision:23992; number_of_response:1; }","duration":"186.535166ms","start":"2026-07-22T22:51:18.934266Z","end":"2026-07-22T22:51:19.120801Z","steps":["trace[1206733585] 'process raft request'  (duration: 186.354571ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:19.120998Z","caller":"traceutil/trace.go:171","msg":"trace[983871464] transaction","detail":"{read_only:false; response_revision:23993; number_of_response:1; }","duration":"186.622589ms","start":"2026-07-22T22:51:18.934355Z","end":"2026-07-22T22:51:19.120978Z","steps":["trace[983871464] 'process raft request'  (duration: 186.413743ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:23.352203Z","caller":"traceutil/trace.go:171","msg":"trace[548074759] transaction","detail":"{read_only:false; response_revision:24029; number_of_response:1; }","duration":"114.937806ms","start":"2026-07-22T22:51:23.237226Z","end":"2026-07-22T22:51:23.352164Z","steps":["trace[548074759] 'process raft request'  (duration: 114.785371ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:23.744073Z","caller":"traceutil/trace.go:171","msg":"trace[744907456] transaction","detail":"{read_only:false; response_revision:24031; number_of_response:1; }","duration":"185.240461ms","start":"2026-07-22T22:51:23.558763Z","end":"2026-07-22T22:51:23.744003Z","steps":["trace[744907456] 'process raft request'  (duration: 185.091927ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:25.252178Z","caller":"traceutil/trace.go:171","msg":"trace[1474086125] transaction","detail":"{read_only:false; response_revision:24035; number_of_response:1; }","duration":"303.369795ms","start":"2026-07-22T22:51:24.948775Z","end":"2026-07-22T22:51:25.252145Z","steps":["trace[1474086125] 'process raft request'  (duration: 303.145448ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:25.252417Z","caller":"traceutil/trace.go:171","msg":"trace[673656200] transaction","detail":"{read_only:false; response_revision:24037; number_of_response:1; }","duration":"299.674273ms","start":"2026-07-22T22:51:24.952731Z","end":"2026-07-22T22:51:25.252406Z","steps":["trace[673656200] 'process raft request'  (duration: 299.58383ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:25.252597Z","caller":"traceutil/trace.go:171","msg":"trace[954791920] linearizableReadLoop","detail":"{readStateIndex:24823; appliedIndex:24818; }","duration":"168.211207ms","start":"2026-07-22T22:51:25.08436Z","end":"2026-07-22T22:51:25.252571Z","steps":["trace[954791920] 'read index received'  (duration: 167.534838ms)","trace[954791920] 'applied index is now lower than readState.Index'  (duration: 675.219µs)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:51:25.252744Z","caller":"traceutil/trace.go:171","msg":"trace[292514023] transaction","detail":"{read_only:false; response_revision:24036; number_of_response:1; }","duration":"300.065863ms","start":"2026-07-22T22:51:24.952666Z","end":"2026-07-22T22:51:25.252732Z","steps":["trace[292514023] 'process raft request'  (duration: 299.5831ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:25.252832Z","caller":"traceutil/trace.go:171","msg":"trace[1751298856] transaction","detail":"{read_only:false; response_revision:24038; number_of_response:1; }","duration":"299.704633ms","start":"2026-07-22T22:51:24.953115Z","end":"2026-07-22T22:51:25.25282Z","steps":["trace[1751298856] 'process raft request'  (duration: 299.248101ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:25.252864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:24.952651Z","time spent":"300.128385ms","remote":"127.0.0.1:50602","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:24024 > 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-07-22T22:51:25.252939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:24.948757Z","time spent":"303.686644ms","remote":"127.0.0.1:50602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24020 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-07-22T22:51:25.253092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.716941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:51:25.253326Z","caller":"traceutil/trace.go:171","msg":"trace[402788001] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:24039; }","duration":"168.800003ms","start":"2026-07-22T22:51:25.084326Z","end":"2026-07-22T22:51:25.253126Z","steps":["trace[402788001] 'agreement among raft nodes before linearized reading'  (duration: 168.711641ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:25.253118Z","caller":"traceutil/trace.go:171","msg":"trace[855692123] transaction","detail":"{read_only:false; response_revision:24039; number_of_response:1; }","duration":"299.894338ms","start":"2026-07-22T22:51:24.953177Z","end":"2026-07-22T22:51:25.253072Z","steps":["trace[855692123] 'process raft request'  (duration: 299.308282ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:25.253352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.694206ms","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-07-22T22:51:25.253388Z","caller":"traceutil/trace.go:171","msg":"trace[2075434961] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24039; }","duration":"161.750287ms","start":"2026-07-22T22:51:25.091627Z","end":"2026-07-22T22:51:25.253378Z","steps":["trace[2075434961] 'agreement among raft nodes before linearized reading'  (duration: 161.350056ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:25.253458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:24.95317Z","time spent":"300.208347ms","remote":"127.0.0.1:50602","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:24023 > 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-07-22T22:51:25.253524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.791811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-07-22T22:51:25.253549Z","caller":"traceutil/trace.go:171","msg":"trace[1591255779] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24039; }","duration":"110.816681ms","start":"2026-07-22T22:51:25.142724Z","end":"2026-07-22T22:51:25.253541Z","steps":["trace[1591255779] 'agreement among raft nodes before linearized reading'  (duration: 110.740709ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:25.519657Z","caller":"traceutil/trace.go:171","msg":"trace[1869768294] transaction","detail":"{read_only:false; response_revision:24040; number_of_response:1; }","duration":"261.791688ms","start":"2026-07-22T22:51:25.257835Z","end":"2026-07-22T22:51:25.519627Z","steps":["trace[1869768294] 'process raft request'  (duration: 227.166756ms)","trace[1869768294] 'compare'  (duration: 34.398016ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:51:25.687904Z","caller":"traceutil/trace.go:171","msg":"trace[1417763330] transaction","detail":"{read_only:false; response_revision:24042; number_of_response:1; }","duration":"429.896423ms","start":"2026-07-22T22:51:25.257987Z","end":"2026-07-22T22:51:25.687883Z","steps":["trace[1417763330] 'process raft request'  (duration: 429.836451ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:25.688022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:25.257963Z","time spent":"430.000625ms","remote":"127.0.0.1:50602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24028 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-07-22T22:51:25.688008Z","caller":"traceutil/trace.go:171","msg":"trace[1061776295] transaction","detail":"{read_only:false; response_revision:24041; number_of_response:1; }","duration":"430.073758ms","start":"2026-07-22T22:51:25.257878Z","end":"2026-07-22T22:51:25.687952Z","steps":["trace[1061776295] 'process raft request'  (duration: 429.81558ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:25.688084Z","caller":"traceutil/trace.go:171","msg":"trace[444552927] linearizableReadLoop","detail":"{readStateIndex:24826; appliedIndex:24823; }","duration":"258.885498ms","start":"2026-07-22T22:51:25.429181Z","end":"2026-07-22T22:51:25.688067Z","steps":["trace[444552927] 'read index received'  (duration: 55.837213ms)","trace[444552927] 'applied index is now lower than readState.Index'  (duration: 203.046235ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:51:25.688088Z","caller":"traceutil/trace.go:171","msg":"trace[1696969753] transaction","detail":"{read_only:false; response_revision:24043; number_of_response:1; }","duration":"235.301222ms","start":"2026-07-22T22:51:25.452767Z","end":"2026-07-22T22:51:25.688068Z","steps":["trace[1696969753] 'process raft request'  (duration: 235.089676ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:25.688132Z","caller":"traceutil/trace.go:171","msg":"trace[2143309958] transaction","detail":"{read_only:false; response_revision:24044; number_of_response:1; }","duration":"203.908379ms","start":"2026-07-22T22:51:25.484196Z","end":"2026-07-22T22:51:25.688104Z","steps":["trace[2143309958] 'process raft request'  (duration: 203.791846ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:25.688215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.032031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/applicationcredentials/\" range_end:\"/registry/openstack.k-orc.cloud/applicationcredentials0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:51:25.688258Z","caller":"traceutil/trace.go:171","msg":"trace[683697446] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/applicationcredentials/; range_end:/registry/openstack.k-orc.cloud/applicationcredentials0; response_count:0; response_revision:24044; }","duration":"259.104984ms","start":"2026-07-22T22:51:25.429136Z","end":"2026-07-22T22:51:25.688241Z","steps":["trace[683697446] 'agreement among raft nodes before linearized reading'  (duration: 259.019881ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:25.688249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:25.257863Z","time spent":"430.249452ms","remote":"127.0.0.1:50602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24027 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-07-22T22:51:25.688286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.141383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:51:25.688319Z","caller":"traceutil/trace.go:171","msg":"trace[1689030786] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:24044; }","duration":"133.217155ms","start":"2026-07-22T22:51:25.555094Z","end":"2026-07-22T22:51:25.688311Z","steps":["trace[1689030786] 'agreement among raft nodes before linearized reading'  (duration: 133.166963ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:25.855235Z","caller":"traceutil/trace.go:171","msg":"trace[704248762] linearizableReadLoop","detail":"{readStateIndex:24829; appliedIndex:24828; }","duration":"101.097181ms","start":"2026-07-22T22:51:25.754082Z","end":"2026-07-22T22:51:25.855179Z","steps":["trace[704248762] 'read index received'  (duration: 99.585989ms)","trace[704248762] 'applied index is now lower than readState.Index'  (duration: 1.510092ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:51:25.855283Z","caller":"traceutil/trace.go:171","msg":"trace[1274297035] transaction","detail":"{read_only:false; response_revision:24045; number_of_response:1; }","duration":"102.930392ms","start":"2026-07-22T22:51:25.752317Z","end":"2026-07-22T22:51:25.855247Z","steps":["trace[1274297035] 'process raft request'  (duration: 101.356148ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:25.85561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.498812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-07-22T22:51:25.855773Z","caller":"traceutil/trace.go:171","msg":"trace[1693013743] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24045; }","duration":"101.707558ms","start":"2026-07-22T22:51:25.754047Z","end":"2026-07-22T22:51:25.855755Z","steps":["trace[1693013743] 'agreement among raft nodes before linearized reading'  (duration: 101.359348ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:26.014299Z","caller":"traceutil/trace.go:171","msg":"trace[821638536] transaction","detail":"{read_only:false; response_revision:24046; number_of_response:1; }","duration":"154.64028ms","start":"2026-07-22T22:51:25.859617Z","end":"2026-07-22T22:51:26.014257Z","steps":["trace[821638536] 'process raft request'  (duration: 140.828056ms)","trace[821638536] 'compare'  (duration: 13.699411ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:51:26.084953Z","caller":"traceutil/trace.go:171","msg":"trace[576470165] transaction","detail":"{read_only:false; response_revision:24047; number_of_response:1; }","duration":"224.310568ms","start":"2026-07-22T22:51:25.860617Z","end":"2026-07-22T22:51:26.084927Z","steps":["trace[576470165] 'process raft request'  (duration: 224.151753ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:26.660157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.606385ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249528837 > lease_revoke:<id:0c869f8bdd332ef1>","response":"size:29"}
{"level":"info","ts":"2026-07-22T22:51:26.660276Z","caller":"traceutil/trace.go:171","msg":"trace[1779440684] linearizableReadLoop","detail":"{readStateIndex:24832; appliedIndex:24831; }","duration":"562.618763ms","start":"2026-07-22T22:51:26.097636Z","end":"2026-07-22T22:51:26.660255Z","steps":["trace[1779440684] 'read index received'  (duration: 118.810223ms)","trace[1779440684] 'applied index is now lower than readState.Index'  (duration: 443.8068ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:51:26.660635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.991324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/servergroups/\" range_end:\"/registry/openstack.k-orc.cloud/servergroups0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:51:26.660692Z","caller":"traceutil/trace.go:171","msg":"trace[549616392] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/servergroups/; range_end:/registry/openstack.k-orc.cloud/servergroups0; response_count:0; response_revision:24047; }","duration":"563.053706ms","start":"2026-07-22T22:51:26.097621Z","end":"2026-07-22T22:51:26.660674Z","steps":["trace[549616392] 'agreement among raft nodes before linearized reading'  (duration: 562.951363ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:26.660741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:26.097562Z","time spent":"563.166149ms","remote":"127.0.0.1:51604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/servergroups/\" range_end:\"/registry/openstack.k-orc.cloud/servergroups0\" count_only:true "}
{"level":"warn","ts":"2026-07-22T22:51:26.660812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.909679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:51:26.660915Z","caller":"traceutil/trace.go:171","msg":"trace[1225590547] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24047; }","duration":"523.015543ms","start":"2026-07-22T22:51:26.137872Z","end":"2026-07-22T22:51:26.660888Z","steps":["trace[1225590547] 'agreement among raft nodes before linearized reading'  (duration: 522.864699ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:26.660978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:26.137808Z","time spent":"523.156456ms","remote":"127.0.0.1:50350","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-07-22T22:51:27.12591Z","caller":"traceutil/trace.go:171","msg":"trace[495904100] transaction","detail":"{read_only:false; response_revision:24048; number_of_response:1; }","duration":"123.263127ms","start":"2026-07-22T22:51:27.002618Z","end":"2026-07-22T22:51:27.125881Z","steps":["trace[495904100] 'process raft request'  (duration: 123.051981ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:27.425362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.870064ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249528853 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24036 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-22T22:51:27.425441Z","caller":"traceutil/trace.go:171","msg":"trace[1939858961] transaction","detail":"{read_only:false; response_revision:24049; number_of_response:1; }","duration":"166.88798ms","start":"2026-07-22T22:51:27.25854Z","end":"2026-07-22T22:51:27.425428Z","steps":["trace[1939858961] 'process raft request'  (duration: 65.888702ms)","trace[1939858961] 'compare'  (duration: 100.763041ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:51:27.714948Z","caller":"traceutil/trace.go:171","msg":"trace[172125001] transaction","detail":"{read_only:false; response_revision:24050; number_of_response:1; }","duration":"456.083222ms","start":"2026-07-22T22:51:27.258836Z","end":"2026-07-22T22:51:27.714919Z","steps":["trace[172125001] 'process raft request'  (duration: 436.525058ms)","trace[172125001] 'compare'  (duration: 19.026739ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:51:27.715137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:27.258822Z","time spent":"456.191274ms","remote":"127.0.0.1:50602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-system/controller-leader-election-capi\" mod_revision:24038 > success:<request_put:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/capi-system/controller-leader-election-capi\" > >"}
{"level":"info","ts":"2026-07-22T22:51:27.71529Z","caller":"traceutil/trace.go:171","msg":"trace[956505587] linearizableReadLoop","detail":"{readStateIndex:24838; appliedIndex:24833; }","duration":"429.212714ms","start":"2026-07-22T22:51:27.286056Z","end":"2026-07-22T22:51:27.715269Z","steps":["trace[956505587] 'read index received'  (duration: 38.365567ms)","trace[956505587] 'applied index is now lower than readState.Index'  (duration: 390.846157ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:51:27.71533Z","caller":"traceutil/trace.go:171","msg":"trace[728109893] transaction","detail":"{read_only:false; response_revision:24051; number_of_response:1; }","duration":"456.434391ms","start":"2026-07-22T22:51:27.258869Z","end":"2026-07-22T22:51:27.715304Z","steps":["trace[728109893] 'process raft request'  (duration: 455.832965ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:27.715365Z","caller":"traceutil/trace.go:171","msg":"trace[1193044068] transaction","detail":"{read_only:false; response_revision:24053; number_of_response:1; }","duration":"454.169268ms","start":"2026-07-22T22:51:27.26116Z","end":"2026-07-22T22:51:27.715329Z","steps":["trace[1193044068] 'process raft request'  (duration: 453.805668ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:27.715388Z","caller":"traceutil/trace.go:171","msg":"trace[977878862] transaction","detail":"{read_only:false; response_revision:24052; number_of_response:1; }","duration":"455.981309ms","start":"2026-07-22T22:51:27.259052Z","end":"2026-07-22T22:51:27.715033Z","steps":["trace[977878862] 'process raft request'  (duration: 455.811434ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:27.715509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:27.258838Z","time spent":"456.561285ms","remote":"127.0.0.1:50602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":605,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24037 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:504 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >"}
{"level":"warn","ts":"2026-07-22T22:51:27.715541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:27.261149Z","time spent":"454.298012ms","remote":"127.0.0.1:50602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:24035 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"info","ts":"2026-07-22T22:51:27.715609Z","caller":"traceutil/trace.go:171","msg":"trace[619840059] transaction","detail":"{read_only:false; response_revision:24054; number_of_response:1; }","duration":"238.169503ms","start":"2026-07-22T22:51:27.477407Z","end":"2026-07-22T22:51:27.715577Z","steps":["trace[619840059] 'process raft request'  (duration: 237.791202ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:27.715719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:27.259042Z","time spent":"456.436761ms","remote":"127.0.0.1:50602","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:24039 > 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-07-22T22:51:27.715753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.700947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:51:27.715795Z","caller":"traceutil/trace.go:171","msg":"trace[1723939671] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:24054; }","duration":"429.781371ms","start":"2026-07-22T22:51:27.286001Z","end":"2026-07-22T22:51:27.715783Z","steps":["trace[1723939671] 'agreement among raft nodes before linearized reading'  (duration: 429.365809ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:27.715827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:27.28598Z","time spent":"429.838942ms","remote":"127.0.0.1:47032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true "}
{"level":"warn","ts":"2026-07-22T22:51:27.71647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.456603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-07-22T22:51:27.717056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.460478ms","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-07-22T22:51:27.717103Z","caller":"traceutil/trace.go:171","msg":"trace[94480878] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24055; }","duration":"194.5377ms","start":"2026-07-22T22:51:27.522553Z","end":"2026-07-22T22:51:27.717091Z","steps":["trace[94480878] 'agreement among raft nodes before linearized reading'  (duration: 194.357465ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:27.717188Z","caller":"traceutil/trace.go:171","msg":"trace[41075485] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:24055; }","duration":"370.196474ms","start":"2026-07-22T22:51:27.346899Z","end":"2026-07-22T22:51:27.717096Z","steps":["trace[41075485] 'agreement among raft nodes before linearized reading'  (duration: 369.495615ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:27.717388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:27.346874Z","time spent":"370.42218ms","remote":"127.0.0.1:33658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":31,"request content":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true "}
{"level":"info","ts":"2026-07-22T22:51:27.961326Z","caller":"traceutil/trace.go:171","msg":"trace[29630990] transaction","detail":"{read_only:false; response_revision:24057; number_of_response:1; }","duration":"240.289741ms","start":"2026-07-22T22:51:27.721013Z","end":"2026-07-22T22:51:27.961303Z","steps":["trace[29630990] 'process raft request'  (duration: 155.949796ms)","trace[29630990] 'compare'  (duration: 84.177161ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:51:27.961475Z","caller":"traceutil/trace.go:171","msg":"trace[310817427] linearizableReadLoop","detail":"{readStateIndex:24843; appliedIndex:24841; }","duration":"101.543393ms","start":"2026-07-22T22:51:27.859907Z","end":"2026-07-22T22:51:27.961451Z","steps":["trace[310817427] 'read index received'  (duration: 16.939311ms)","trace[310817427] 'applied index is now lower than readState.Index'  (duration: 84.602882ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:51:27.961665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.740369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-07-22T22:51:27.961705Z","caller":"traceutil/trace.go:171","msg":"trace[2147310081] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24058; }","duration":"101.822131ms","start":"2026-07-22T22:51:27.859872Z","end":"2026-07-22T22:51:27.961694Z","steps":["trace[2147310081] 'agreement among raft nodes before linearized reading'  (duration: 101.666737ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:27.961909Z","caller":"traceutil/trace.go:171","msg":"trace[1740431136] transaction","detail":"{read_only:false; response_revision:24058; number_of_response:1; }","duration":"239.964932ms","start":"2026-07-22T22:51:27.721922Z","end":"2026-07-22T22:51:27.961887Z","steps":["trace[1740431136] 'process raft request'  (duration: 239.334685ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:28.232864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.276235ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249528866 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24045 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-22T22:51:28.232993Z","caller":"traceutil/trace.go:171","msg":"trace[1851538984] linearizableReadLoop","detail":"{readStateIndex:24844; appliedIndex:24843; }","duration":"214.679899ms","start":"2026-07-22T22:51:28.018292Z","end":"2026-07-22T22:51:28.232972Z","steps":["trace[1851538984] 'read index received'  (duration: 76.161878ms)","trace[1851538984] 'applied index is now lower than readState.Index'  (duration: 138.516391ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:51:28.233064Z","caller":"traceutil/trace.go:171","msg":"trace[553987461] transaction","detail":"{read_only:false; response_revision:24059; number_of_response:1; }","duration":"267.126187ms","start":"2026-07-22T22:51:27.965903Z","end":"2026-07-22T22:51:28.233029Z","steps":["trace[553987461] 'process raft request'  (duration: 128.581405ms)","trace[553987461] 'compare'  (duration: 138.144161ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:51:28.23343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.127751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-07-22T22:51:28.233491Z","caller":"traceutil/trace.go:171","msg":"trace[1943223742] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24059; }","duration":"215.223584ms","start":"2026-07-22T22:51:28.018252Z","end":"2026-07-22T22:51:28.233476Z","steps":["trace[1943223742] 'agreement among raft nodes before linearized reading'  (duration: 214.998168ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:28.233843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.433446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-07-22T22:51:28.233895Z","caller":"traceutil/trace.go:171","msg":"trace[2095304698] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24059; }","duration":"144.535699ms","start":"2026-07-22T22:51:28.089347Z","end":"2026-07-22T22:51:28.233883Z","steps":["trace[2095304698] 'agreement among raft nodes before linearized reading'  (duration: 144.406496ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:28.233529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.985339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/domains/\" range_end:\"/registry/openstack.k-orc.cloud/domains0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:51:28.234132Z","caller":"traceutil/trace.go:171","msg":"trace[2001706114] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/domains/; range_end:/registry/openstack.k-orc.cloud/domains0; response_count:0; response_revision:24059; }","duration":"155.463923ms","start":"2026-07-22T22:51:28.078476Z","end":"2026-07-22T22:51:28.23394Z","steps":["trace[2001706114] 'agreement among raft nodes before linearized reading'  (duration: 154.98993ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:28.562342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.288062ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249528871 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" mod_revision:24029 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" value_size:518 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-control-plane-system/kubeadm-control-plane-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-22T22:51:28.562442Z","caller":"traceutil/trace.go:171","msg":"trace[1073377055] linearizableReadLoop","detail":"{readStateIndex:24847; appliedIndex:24846; }","duration":"162.160729ms","start":"2026-07-22T22:51:28.400269Z","end":"2026-07-22T22:51:28.562429Z","steps":["trace[1073377055] 'read index received'  (duration: 31.682731ms)","trace[1073377055] 'applied index is now lower than readState.Index'  (duration: 130.476957ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:51:28.562514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.241971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:51:28.562532Z","caller":"traceutil/trace.go:171","msg":"trace[2062397039] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:24062; }","duration":"162.298582ms","start":"2026-07-22T22:51:28.400227Z","end":"2026-07-22T22:51:28.562525Z","steps":["trace[2062397039] 'agreement among raft nodes before linearized reading'  (duration: 162.23368ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:28.5627Z","caller":"traceutil/trace.go:171","msg":"trace[1285332516] transaction","detail":"{read_only:false; response_revision:24062; number_of_response:1; }","duration":"205.676009ms","start":"2026-07-22T22:51:28.356993Z","end":"2026-07-22T22:51:28.562669Z","steps":["trace[1285332516] 'process raft request'  (duration: 74.999046ms)","trace[1285332516] 'compare'  (duration: 130.159039ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:51:28.754386Z","caller":"traceutil/trace.go:171","msg":"trace[18745212] transaction","detail":"{read_only:false; response_revision:24063; number_of_response:1; }","duration":"111.355346ms","start":"2026-07-22T22:51:28.642963Z","end":"2026-07-22T22:51:28.754318Z","steps":["trace[18745212] 'process raft request'  (duration: 111.185271ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:29.200882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.886481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-07-22T22:51:29.200918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.84254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:51:29.200971Z","caller":"traceutil/trace.go:171","msg":"trace[421588717] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:24063; }","duration":"320.989274ms","start":"2026-07-22T22:51:28.879961Z","end":"2026-07-22T22:51:29.20095Z","steps":["trace[421588717] 'count revisions from in-memory index tree'  (duration: 320.803219ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:29.200997Z","caller":"traceutil/trace.go:171","msg":"trace[1581036663] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:24063; }","duration":"270.935272ms","start":"2026-07-22T22:51:28.930039Z","end":"2026-07-22T22:51:29.200974Z","steps":["trace[1581036663] 'count revisions from in-memory index tree'  (duration: 270.750367ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:29.201042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:28.879917Z","time spent":"321.105278ms","remote":"127.0.0.1:45068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "}
{"level":"warn","ts":"2026-07-22T22:51:36.144494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.115829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-07-22T22:51:36.144763Z","caller":"traceutil/trace.go:171","msg":"trace[1301001075] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24115; }","duration":"152.425858ms","start":"2026-07-22T22:51:35.992309Z","end":"2026-07-22T22:51:36.144735Z","steps":["trace[1301001075] 'range keys from in-memory index tree'  (duration: 151.979455ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:36.145018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.94893ms","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-07-22T22:51:36.145164Z","caller":"traceutil/trace.go:171","msg":"trace[597431614] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24115; }","duration":"145.141566ms","start":"2026-07-22T22:51:36.000004Z","end":"2026-07-22T22:51:36.145146Z","steps":["trace[597431614] 'range keys from in-memory index tree'  (duration: 144.782366ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:36.145517Z","caller":"traceutil/trace.go:171","msg":"trace[491956683] transaction","detail":"{read_only:false; response_revision:24116; number_of_response:1; }","duration":"127.589098ms","start":"2026-07-22T22:51:36.017908Z","end":"2026-07-22T22:51:36.145497Z","steps":["trace[491956683] 'process raft request'  (duration: 125.12231ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:36.754626Z","caller":"traceutil/trace.go:171","msg":"trace[1566795061] transaction","detail":"{read_only:false; response_revision:24117; number_of_response:1; }","duration":"604.779614ms","start":"2026-07-22T22:51:36.149819Z","end":"2026-07-22T22:51:36.754599Z","steps":["trace[1566795061] 'process raft request'  (duration: 604.577519ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:36.75478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:36.149793Z","time spent":"604.906508ms","remote":"127.0.0.1:50602","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:24102 > 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-07-22T22:51:37.27779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.902699ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249529002 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24103 > 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:18"}
{"level":"info","ts":"2026-07-22T22:51:37.278521Z","caller":"traceutil/trace.go:171","msg":"trace[1711022814] transaction","detail":"{read_only:false; response_revision:24118; number_of_response:1; }","duration":"1.128365204s","start":"2026-07-22T22:51:36.150028Z","end":"2026-07-22T22:51:37.278393Z","steps":["trace[1711022814] 'process raft request'  (duration: 836.754665ms)","trace[1711022814] 'compare'  (duration: 290.346003ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:51:37.279001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:36.149998Z","time spent":"1.128909878s","remote":"127.0.0.1:50602","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:24103 > 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":"warn","ts":"2026-07-22T22:51:37.61987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.945317ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249529003 > lease_revoke:<id:0c869f8bdd332fa1>","response":"size:29"}
{"level":"info","ts":"2026-07-22T22:51:37.62005Z","caller":"traceutil/trace.go:171","msg":"trace[121388237] linearizableReadLoop","detail":"{readStateIndex:24905; appliedIndex:24902; }","duration":"1.355215632s","start":"2026-07-22T22:51:36.26482Z","end":"2026-07-22T22:51:37.620035Z","steps":["trace[121388237] 'read index received'  (duration: 489.46642ms)","trace[121388237] 'applied index is now lower than readState.Index'  (duration: 865.748472ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:51:37.620256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.355427797s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-07-22T22:51:37.620332Z","caller":"traceutil/trace.go:171","msg":"trace[233296975] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24118; }","duration":"1.355613353s","start":"2026-07-22T22:51:36.26469Z","end":"2026-07-22T22:51:37.620304Z","steps":["trace[233296975] 'agreement among raft nodes before linearized reading'  (duration: 1.355419188s)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:37.620365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:36.264664Z","time spent":"1.355695475s","remote":"127.0.0.1:50602","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-07-22T22:51:37.620644Z","caller":"traceutil/trace.go:171","msg":"trace[338986559] transaction","detail":"{read_only:false; response_revision:24119; number_of_response:1; }","duration":"384.318336ms","start":"2026-07-22T22:51:37.236306Z","end":"2026-07-22T22:51:37.620625Z","steps":["trace[338986559] 'process raft request'  (duration: 383.650648ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:37.620726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:37.236281Z","time spent":"384.386868ms","remote":"127.0.0.1:50602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24108 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-07-22T22:51:38.009462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.693585ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249529005 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:24109 > 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:18"}
{"level":"info","ts":"2026-07-22T22:51:38.009632Z","caller":"traceutil/trace.go:171","msg":"trace[669089087] transaction","detail":"{read_only:false; response_revision:24121; number_of_response:1; }","duration":"385.405676ms","start":"2026-07-22T22:51:37.62421Z","end":"2026-07-22T22:51:38.009615Z","steps":["trace[669089087] 'process raft request'  (duration: 385.350595ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:38.009693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:37.62419Z","time spent":"385.472037ms","remote":"127.0.0.1:50602","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:24104 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-07-22T22:51:38.009862Z","caller":"traceutil/trace.go:171","msg":"trace[1288322081] transaction","detail":"{read_only:false; response_revision:24120; number_of_response:1; }","duration":"458.855219ms","start":"2026-07-22T22:51:37.550996Z","end":"2026-07-22T22:51:38.009851Z","steps":["trace[1288322081] 'process raft request'  (duration: 86.68133ms)","trace[1288322081] 'compare'  (duration: 371.586732ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:51:38.009946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:37.550977Z","time spent":"458.9069ms","remote":"127.0.0.1:50602","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:24109 > 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-07-22T22:51:38.010065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.641179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-22T22:51:38.010004Z","caller":"traceutil/trace.go:171","msg":"trace[894690153] linearizableReadLoop","detail":"{readStateIndex:24907; appliedIndex:24906; }","duration":"389.832919ms","start":"2026-07-22T22:51:37.620114Z","end":"2026-07-22T22:51:38.009947Z","steps":["trace[894690153] 'read index received'  (duration: 17.497587ms)","trace[894690153] 'applied index is now lower than readState.Index'  (duration: 372.331612ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:51:38.010064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.343912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-07-22T22:51:38.010155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"739.629986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-22T22:51:38.010156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.198104134s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-22T22:51:38.010178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.568343767s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:51:38.010191Z","caller":"traceutil/trace.go:171","msg":"trace[1221179418] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagerconfigs/; range_end:/registry/monitoring.coreos.com/alertmanagerconfigs0; response_count:0; response_revision:24121; }","duration":"739.666637ms","start":"2026-07-22T22:51:37.270515Z","end":"2026-07-22T22:51:38.010181Z","steps":["trace[1221179418] 'agreement among raft nodes before linearized reading'  (duration: 739.614455ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:38.010223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:37.270494Z","time spent":"739.721098ms","remote":"127.0.0.1:59688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true "}
{"level":"info","ts":"2026-07-22T22:51:38.010217Z","caller":"traceutil/trace.go:171","msg":"trace[1808520230] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:24121; }","duration":"1.198154835s","start":"2026-07-22T22:51:36.812039Z","end":"2026-07-22T22:51:38.010194Z","steps":["trace[1808520230] 'agreement among raft nodes before linearized reading'  (duration: 1.198084783s)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:38.010194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"944.478771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-22T22:51:38.010249Z","caller":"traceutil/trace.go:171","msg":"trace[1844522892] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:24121; }","duration":"1.568426261s","start":"2026-07-22T22:51:36.441785Z","end":"2026-07-22T22:51:38.010211Z","steps":["trace[1844522892] 'agreement among raft nodes before linearized reading'  (duration: 1.568354549s)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:38.010079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"939.470962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-07-22T22:51:38.010289Z","caller":"traceutil/trace.go:171","msg":"trace[1107359518] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:24121; }","duration":"944.628705ms","start":"2026-07-22T22:51:37.065636Z","end":"2026-07-22T22:51:38.010265Z","steps":["trace[1107359518] 'agreement among raft nodes before linearized reading'  (duration: 944.389859ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:38.010314Z","caller":"traceutil/trace.go:171","msg":"trace[1647094991] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24121; }","duration":"939.75559ms","start":"2026-07-22T22:51:37.070544Z","end":"2026-07-22T22:51:38.0103Z","steps":["trace[1647094991] 'agreement among raft nodes before linearized reading'  (duration: 939.410471ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:38.010308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:36.441762Z","time spent":"1.568519883s","remote":"127.0.0.1:36230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true "}
{"level":"warn","ts":"2026-07-22T22:51:38.010317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.7284849s","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-07-22T22:51:38.010327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.716526758s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-07-22T22:51:38.010348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:37.065606Z","time spent":"944.725128ms","remote":"127.0.0.1:45064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":75,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "}
{"level":"info","ts":"2026-07-22T22:51:38.010366Z","caller":"traceutil/trace.go:171","msg":"trace[851614166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24121; }","duration":"1.728567933s","start":"2026-07-22T22:51:36.281782Z","end":"2026-07-22T22:51:38.01035Z","steps":["trace[851614166] 'agreement among raft nodes before linearized reading'  (duration: 1.728414478s)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:38.010277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:36.812008Z","time spent":"1.198251578s","remote":"127.0.0.1:55098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "}
{"level":"info","ts":"2026-07-22T22:51:38.01037Z","caller":"traceutil/trace.go:171","msg":"trace[842275754] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24121; }","duration":"1.71660712s","start":"2026-07-22T22:51:36.293751Z","end":"2026-07-22T22:51:38.010358Z","steps":["trace[842275754] 'agreement among raft nodes before linearized reading'  (duration: 1.716415874s)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:38.010948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:36.293732Z","time spent":"1.717191046s","remote":"127.0.0.1:50602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-07-22T22:51:38.010096Z","caller":"traceutil/trace.go:171","msg":"trace[941554259] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:24121; }","duration":"587.67242ms","start":"2026-07-22T22:51:37.422414Z","end":"2026-07-22T22:51:38.010086Z","steps":["trace[941554259] 'agreement among raft nodes before linearized reading'  (duration: 587.604768ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:38.011064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.328498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:31 size:268420"}
{"level":"info","ts":"2026-07-22T22:51:38.011157Z","caller":"traceutil/trace.go:171","msg":"trace[1533796715] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:31; response_revision:24121; }","duration":"734.461051ms","start":"2026-07-22T22:51:37.276674Z","end":"2026-07-22T22:51:38.011135Z","steps":["trace[1533796715] 'agreement among raft nodes before linearized reading'  (duration: 733.31933ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:38.011206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:37.276652Z","time spent":"734.542074ms","remote":"127.0.0.1:50786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":31,"response size":268443,"request content":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" "}
{"level":"warn","ts":"2026-07-22T22:51:38.010064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.589933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:51:38.011496Z","caller":"traceutil/trace.go:171","msg":"trace[160712670] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:24121; }","duration":"632.041664ms","start":"2026-07-22T22:51:37.37943Z","end":"2026-07-22T22:51:38.011472Z","steps":["trace[160712670] 'agreement among raft nodes before linearized reading'  (duration: 630.526642ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:38.010397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:36.28176Z","time spent":"1.728630075s","remote":"127.0.0.1:50602","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-07-22T22:51:38.011518Z","caller":"traceutil/trace.go:171","msg":"trace[2109091732] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24121; }","duration":"418.62431ms","start":"2026-07-22T22:51:37.591523Z","end":"2026-07-22T22:51:38.010147Z","steps":["trace[2109091732] 'agreement among raft nodes before linearized reading'  (duration: 418.443425ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:38.011569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:37.379359Z","time spent":"632.186738ms","remote":"127.0.0.1:47052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true "}
{"level":"warn","ts":"2026-07-22T22:51:38.011591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:37.591468Z","time spent":"420.10035ms","remote":"127.0.0.1:54756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-07-22T22:51:38.010389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.524881079s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-07-22T22:51:38.011681Z","caller":"traceutil/trace.go:171","msg":"trace[1395788297] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:24121; }","duration":"1.526216396s","start":"2026-07-22T22:51:36.485449Z","end":"2026-07-22T22:51:38.011665Z","steps":["trace[1395788297] 'agreement among raft nodes before linearized reading'  (duration: 1.524726365s)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:38.011721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:37.422381Z","time spent":"588.676468ms","remote":"127.0.0.1:50776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":31,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "}
{"level":"warn","ts":"2026-07-22T22:51:38.011755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:36.485426Z","time spent":"1.526298299s","remote":"127.0.0.1:50446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":231,"response size":32,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "}
{"level":"warn","ts":"2026-07-22T22:51:38.010495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:37.070505Z","time spent":"939.980466ms","remote":"127.0.0.1:50528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-07-22T22:51:38.010064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.356840337s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:51:38.01208Z","caller":"traceutil/trace.go:171","msg":"trace[67778881] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters0; response_count:0; response_revision:24121; }","duration":"1.358884404s","start":"2026-07-22T22:51:36.653173Z","end":"2026-07-22T22:51:38.012057Z","steps":["trace[67778881] 'agreement among raft nodes before linearized reading'  (duration: 1.356826097s)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:38.012156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:36.653157Z","time spent":"1.358975706s","remote":"127.0.0.1:47386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true "}
{"level":"info","ts":"2026-07-22T22:51:38.012437Z","caller":"traceutil/trace.go:171","msg":"trace[1775686540] transaction","detail":"{read_only:false; response_revision:24122; number_of_response:1; }","duration":"213.459955ms","start":"2026-07-22T22:51:37.798965Z","end":"2026-07-22T22:51:38.012425Z","steps":["trace[1775686540] 'process raft request'  (duration: 213.231199ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:38.012477Z","caller":"traceutil/trace.go:171","msg":"trace[1492852297] transaction","detail":"{read_only:false; response_revision:24123; number_of_response:1; }","duration":"201.982136ms","start":"2026-07-22T22:51:37.810476Z","end":"2026-07-22T22:51:38.012458Z","steps":["trace[1492852297] 'process raft request'  (duration: 201.843202ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:38.012727Z","caller":"traceutil/trace.go:171","msg":"trace[501657254] transaction","detail":"{read_only:false; response_revision:24124; number_of_response:1; }","duration":"202.133611ms","start":"2026-07-22T22:51:37.810556Z","end":"2026-07-22T22:51:38.012689Z","steps":["trace[501657254] 'process raft request'  (duration: 201.847883ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:38.01302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.835626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-07-22T22:51:38.013004Z","caller":"traceutil/trace.go:171","msg":"trace[1898748754] transaction","detail":"{read_only:false; response_revision:24125; number_of_response:1; }","duration":"201.559735ms","start":"2026-07-22T22:51:37.811422Z","end":"2026-07-22T22:51:38.012981Z","steps":["trace[1898748754] 'process raft request'  (duration: 201.167624ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:38.013026Z","caller":"traceutil/trace.go:171","msg":"trace[222078933] transaction","detail":"{read_only:false; response_revision:24126; number_of_response:1; }","duration":"201.375489ms","start":"2026-07-22T22:51:37.811626Z","end":"2026-07-22T22:51:38.013001Z","steps":["trace[222078933] 'process raft request'  (duration: 201.150863ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:38.013075Z","caller":"traceutil/trace.go:171","msg":"trace[198220816] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24126; }","duration":"199.918149ms","start":"2026-07-22T22:51:37.813143Z","end":"2026-07-22T22:51:38.013061Z","steps":["trace[198220816] 'agreement among raft nodes before linearized reading'  (duration: 199.775175ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:43.090474Z","caller":"traceutil/trace.go:171","msg":"trace[777092600] linearizableReadLoop","detail":"{readStateIndex:25005; appliedIndex:25004; }","duration":"155.083222ms","start":"2026-07-22T22:51:42.935372Z","end":"2026-07-22T22:51:43.090455Z","steps":["trace[777092600] 'read index received'  (duration: 109.430763ms)","trace[777092600] 'applied index is now lower than readState.Index'  (duration: 45.651599ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:51:43.090506Z","caller":"traceutil/trace.go:171","msg":"trace[362663120] transaction","detail":"{read_only:false; response_revision:24217; number_of_response:1; }","duration":"270.177662ms","start":"2026-07-22T22:51:42.820303Z","end":"2026-07-22T22:51:43.090481Z","steps":["trace[362663120] 'process raft request'  (duration: 224.607945ms)","trace[362663120] 'compare'  (duration: 45.423233ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:51:43.090639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.254497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9b33ff05-22e7-4987-9c23-e5db0e1f2f7f\" ","response":"range_response_count:1 size:3643"}
{"level":"info","ts":"2026-07-22T22:51:43.090664Z","caller":"traceutil/trace.go:171","msg":"trace[172928838] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9b33ff05-22e7-4987-9c23-e5db0e1f2f7f; range_end:; response_count:1; response_revision:24217; }","duration":"155.314369ms","start":"2026-07-22T22:51:42.935343Z","end":"2026-07-22T22:51:43.090657Z","steps":["trace[172928838] 'agreement among raft nodes before linearized reading'  (duration: 155.200426ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:43.237302Z","caller":"traceutil/trace.go:171","msg":"trace[1580298272] linearizableReadLoop","detail":"{readStateIndex:25006; appliedIndex:25005; }","duration":"131.507197ms","start":"2026-07-22T22:51:43.105767Z","end":"2026-07-22T22:51:43.237274Z","steps":["trace[1580298272] 'read index received'  (duration: 131.151417ms)","trace[1580298272] 'applied index is now lower than readState.Index'  (duration: 354.83µs)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:51:43.23737Z","caller":"traceutil/trace.go:171","msg":"trace[124173231] transaction","detail":"{read_only:false; response_revision:24218; number_of_response:1; }","duration":"138.625655ms","start":"2026-07-22T22:51:43.098714Z","end":"2026-07-22T22:51:43.23734Z","steps":["trace[124173231] 'process raft request'  (duration: 138.148131ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:43.237627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.833186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-07-22T22:51:43.237704Z","caller":"traceutil/trace.go:171","msg":"trace[716108503] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24218; }","duration":"131.946109ms","start":"2026-07-22T22:51:43.105741Z","end":"2026-07-22T22:51:43.237687Z","steps":["trace[716108503] 'agreement among raft nodes before linearized reading'  (duration: 131.666591ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:43.446345Z","caller":"traceutil/trace.go:171","msg":"trace[286478535] transaction","detail":"{read_only:false; response_revision:24219; number_of_response:1; }","duration":"137.124642ms","start":"2026-07-22T22:51:43.30919Z","end":"2026-07-22T22:51:43.446315Z","steps":["trace[286478535] 'process raft request'  (duration: 70.240313ms)","trace[286478535] 'compare'  (duration: 66.760896ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:51:48.809592Z","caller":"traceutil/trace.go:171","msg":"trace[1451249567] transaction","detail":"{read_only:false; response_revision:24294; number_of_response:1; }","duration":"183.542594ms","start":"2026-07-22T22:51:48.626027Z","end":"2026-07-22T22:51:48.809569Z","steps":["trace[1451249567] 'process raft request'  (duration: 183.42126ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:49.095734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.894931ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249529416 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/cilium.io/ciliumidentities/15788\" mod_revision:1334 > success:<request_put:<key:\"/registry/cilium.io/ciliumidentities/15788\" value_size:3375 >> failure:<request_range:<key:\"/registry/cilium.io/ciliumidentities/15788\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-22T22:51:49.096148Z","caller":"traceutil/trace.go:171","msg":"trace[115244360] transaction","detail":"{read_only:false; response_revision:24295; number_of_response:1; }","duration":"440.676633ms","start":"2026-07-22T22:51:48.655445Z","end":"2026-07-22T22:51:49.096122Z","steps":["trace[115244360] 'process raft request'  (duration: 287.309899ms)","trace[115244360] 'compare'  (duration: 152.759767ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:51:49.096178Z","caller":"traceutil/trace.go:171","msg":"trace[1202502208] transaction","detail":"{read_only:false; response_revision:24296; number_of_response:1; }","duration":"231.042704ms","start":"2026-07-22T22:51:48.865105Z","end":"2026-07-22T22:51:49.096148Z","steps":["trace[1202502208] 'process raft request'  (duration: 230.736805ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:49.096259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:51:48.655419Z","time spent":"440.783975ms","remote":"127.0.0.1:45100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3425,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumidentities/15788\" mod_revision:1334 > success:<request_put:<key:\"/registry/cilium.io/ciliumidentities/15788\" value_size:3375 >> failure:<request_range:<key:\"/registry/cilium.io/ciliumidentities/15788\" > >"}
{"level":"info","ts":"2026-07-22T22:51:49.247262Z","caller":"traceutil/trace.go:171","msg":"trace[1327769161] transaction","detail":"{read_only:false; response_revision:24297; number_of_response:1; }","duration":"141.33765ms","start":"2026-07-22T22:51:49.105895Z","end":"2026-07-22T22:51:49.247232Z","steps":["trace[1327769161] 'process raft request'  (duration: 138.152971ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:51:49.252127Z","caller":"traceutil/trace.go:171","msg":"trace[923266769] linearizableReadLoop","detail":"{readStateIndex:25088; appliedIndex:25086; }","duration":"112.92085ms","start":"2026-07-22T22:51:49.139177Z","end":"2026-07-22T22:51:49.252098Z","steps":["trace[923266769] 'read index received'  (duration: 104.882127ms)","trace[923266769] 'applied index is now lower than readState.Index'  (duration: 8.037513ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:51:49.252539Z","caller":"traceutil/trace.go:171","msg":"trace[499008573] transaction","detail":"{read_only:false; response_revision:24298; number_of_response:1; }","duration":"146.589876ms","start":"2026-07-22T22:51:49.105932Z","end":"2026-07-22T22:51:49.252522Z","steps":["trace[499008573] 'process raft request'  (duration: 146.02652ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:49.252848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.66299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:51:49.252894Z","caller":"traceutil/trace.go:171","msg":"trace[332425136] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24298; }","duration":"113.759093ms","start":"2026-07-22T22:51:49.139125Z","end":"2026-07-22T22:51:49.252884Z","steps":["trace[332425136] 'agreement among raft nodes before linearized reading'  (duration: 113.673301ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:51:49.253167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.848623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-07-22T22:51:49.253196Z","caller":"traceutil/trace.go:171","msg":"trace[960862845] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:24298; }","duration":"105.915754ms","start":"2026-07-22T22:51:49.147271Z","end":"2026-07-22T22:51:49.253187Z","steps":["trace[960862845] 'agreement among raft nodes before linearized reading'  (duration: 105.820962ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:19.721227Z","caller":"traceutil/trace.go:171","msg":"trace[138406000] linearizableReadLoop","detail":"{readStateIndex:25350; appliedIndex:25349; }","duration":"122.681641ms","start":"2026-07-22T22:52:19.598523Z","end":"2026-07-22T22:52:19.721205Z","steps":["trace[138406000] 'read index received'  (duration: 122.65079ms)","trace[138406000] 'applied index is now lower than readState.Index'  (duration: 30.001µs)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:52:19.721453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.910217ms","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-07-22T22:52:19.721495Z","caller":"traceutil/trace.go:171","msg":"trace[1072731945] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24553; }","duration":"122.99149ms","start":"2026-07-22T22:52:19.598492Z","end":"2026-07-22T22:52:19.721483Z","steps":["trace[1072731945] 'agreement among raft nodes before linearized reading'  (duration: 122.811205ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:19.721569Z","caller":"traceutil/trace.go:171","msg":"trace[1719299659] transaction","detail":"{read_only:false; response_revision:24553; number_of_response:1; }","duration":"323.918557ms","start":"2026-07-22T22:52:19.397633Z","end":"2026-07-22T22:52:19.721551Z","steps":["trace[1719299659] 'process raft request'  (duration: 323.433373ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:19.721675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:19.397616Z","time spent":"324.000908ms","remote":"127.0.0.1:50602","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:24538 > 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":"info","ts":"2026-07-22T22:52:19.76646Z","caller":"traceutil/trace.go:171","msg":"trace[1860344297] transaction","detail":"{read_only:false; response_revision:24554; number_of_response:1; }","duration":"126.58468ms","start":"2026-07-22T22:52:19.639854Z","end":"2026-07-22T22:52:19.766439Z","steps":["trace[1860344297] 'process raft request'  (duration: 126.498797ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:20.028746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.68222ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249530063 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24539 > 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:18"}
{"level":"info","ts":"2026-07-22T22:52:20.029004Z","caller":"traceutil/trace.go:171","msg":"trace[897057146] transaction","detail":"{read_only:false; response_revision:24556; number_of_response:1; }","duration":"273.456723ms","start":"2026-07-22T22:52:19.75553Z","end":"2026-07-22T22:52:20.028987Z","steps":["trace[897057146] 'process raft request'  (duration: 273.288478ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:20.029051Z","caller":"traceutil/trace.go:171","msg":"trace[2105626289] transaction","detail":"{read_only:false; response_revision:24555; number_of_response:1; }","duration":"303.119898ms","start":"2026-07-22T22:52:19.725877Z","end":"2026-07-22T22:52:20.028997Z","steps":["trace[2105626289] 'process raft request'  (duration: 152.120119ms)","trace[2105626289] 'compare'  (duration: 150.390462ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:52:20.029247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:19.725859Z","time spent":"303.298314ms","remote":"127.0.0.1:50602","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:24539 > 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":"warn","ts":"2026-07-22T22:52:20.355439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.518191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:52:20.355517Z","caller":"traceutil/trace.go:171","msg":"trace[565371940] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24556; }","duration":"216.655815ms","start":"2026-07-22T22:52:20.138843Z","end":"2026-07-22T22:52:20.355499Z","steps":["trace[565371940] 'range keys from in-memory index tree'  (duration: 216.430258ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:20.355841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.771103ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249530067 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" mod_revision:24541 > success:<request_put:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" value_size:504 >> failure:<request_range:<key:\"/registry/leases/capi-kubeadm-bootstrap-system/kubeadm-bootstrap-manager-leader-election-capi\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-22T22:52:20.355932Z","caller":"traceutil/trace.go:171","msg":"trace[786074389] transaction","detail":"{read_only:false; response_revision:24557; number_of_response:1; }","duration":"209.391142ms","start":"2026-07-22T22:52:20.146525Z","end":"2026-07-22T22:52:20.355916Z","steps":["trace[786074389] 'process raft request'  (duration: 63.474705ms)","trace[786074389] 'compare'  (duration: 145.673361ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:52:20.356268Z","caller":"traceutil/trace.go:171","msg":"trace[1849525445] transaction","detail":"{read_only:false; response_revision:24558; number_of_response:1; }","duration":"200.847745ms","start":"2026-07-22T22:52:20.155407Z","end":"2026-07-22T22:52:20.356255Z","steps":["trace[1849525445] 'process raft request'  (duration: 200.747972ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:20.356457Z","caller":"traceutil/trace.go:171","msg":"trace[260996494] transaction","detail":"{read_only:false; response_revision:24559; number_of_response:1; }","duration":"200.969018ms","start":"2026-07-22T22:52:20.155474Z","end":"2026-07-22T22:52:20.356443Z","steps":["trace[260996494] 'process raft request'  (duration: 200.746722ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:20.356511Z","caller":"traceutil/trace.go:171","msg":"trace[75286233] linearizableReadLoop","detail":"{readStateIndex:25359; appliedIndex:25353; }","duration":"172.237679ms","start":"2026-07-22T22:52:20.184258Z","end":"2026-07-22T22:52:20.356496Z","steps":["trace[75286233] 'read index received'  (duration: 25.743116ms)","trace[75286233] 'applied index is now lower than readState.Index'  (duration: 146.493683ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:52:20.356611Z","caller":"traceutil/trace.go:171","msg":"trace[1205718446] transaction","detail":"{read_only:false; response_revision:24560; number_of_response:1; }","duration":"201.125312ms","start":"2026-07-22T22:52:20.155474Z","end":"2026-07-22T22:52:20.3566Z","steps":["trace[1205718446] 'process raft request'  (duration: 200.860785ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:20.356722Z","caller":"traceutil/trace.go:171","msg":"trace[1931057249] transaction","detail":"{read_only:false; response_revision:24561; number_of_response:1; }","duration":"200.238577ms","start":"2026-07-22T22:52:20.156471Z","end":"2026-07-22T22:52:20.356709Z","steps":["trace[1931057249] 'process raft request'  (duration: 199.940339ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:20.356718Z","caller":"traceutil/trace.go:171","msg":"trace[1068769475] transaction","detail":"{read_only:false; response_revision:24562; number_of_response:1; }","duration":"198.52982ms","start":"2026-07-22T22:52:20.158169Z","end":"2026-07-22T22:52:20.356699Z","steps":["trace[1068769475] 'process raft request'  (duration: 198.278963ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:20.356812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.552498ms","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-07-22T22:52:20.356848Z","caller":"traceutil/trace.go:171","msg":"trace[2077624871] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24562; }","duration":"172.61385ms","start":"2026-07-22T22:52:20.184224Z","end":"2026-07-22T22:52:20.356838Z","steps":["trace[2077624871] 'agreement among raft nodes before linearized reading'  (duration: 172.476526ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:20.795013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.85981ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249530073 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:24507 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-22T22:52:20.795344Z","caller":"traceutil/trace.go:171","msg":"trace[2012516402] transaction","detail":"{read_only:false; response_revision:24564; number_of_response:1; }","duration":"435.287543ms","start":"2026-07-22T22:52:20.360032Z","end":"2026-07-22T22:52:20.795319Z","steps":["trace[2012516402] 'process raft request'  (duration: 435.143619ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:20.795511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:20.360015Z","time spent":"435.442178ms","remote":"127.0.0.1:50602","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:24547 > 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-07-22T22:52:20.79564Z","caller":"traceutil/trace.go:171","msg":"trace[1200419927] linearizableReadLoop","detail":"{readStateIndex:25360; appliedIndex:25359; }","duration":"439.032777ms","start":"2026-07-22T22:52:20.356555Z","end":"2026-07-22T22:52:20.795588Z","steps":["trace[1200419927] 'read index received'  (duration: 130.423886ms)","trace[1200419927] 'applied index is now lower than readState.Index'  (duration: 308.605101ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:52:20.795777Z","caller":"traceutil/trace.go:171","msg":"trace[961557617] transaction","detail":"{read_only:false; response_revision:24563; number_of_response:1; }","duration":"449.465407ms","start":"2026-07-22T22:52:20.346295Z","end":"2026-07-22T22:52:20.79576Z","steps":["trace[961557617] 'process raft request'  (duration: 140.751043ms)","trace[961557617] 'compare'  (duration: 307.531671ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:52:20.796194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.925546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-22T22:52:20.796225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.721429ms","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-07-22T22:52:20.796217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.992512ms","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:6"}
{"level":"info","ts":"2026-07-22T22:52:20.796288Z","caller":"traceutil/trace.go:171","msg":"trace[512220917] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24564; }","duration":"602.833612ms","start":"2026-07-22T22:52:20.19344Z","end":"2026-07-22T22:52:20.796274Z","steps":["trace[512220917] 'agreement among raft nodes before linearized reading'  (duration: 602.618626ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:20.796294Z","caller":"traceutil/trace.go:171","msg":"trace[1040537459] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24564; }","duration":"438.07556ms","start":"2026-07-22T22:52:20.358194Z","end":"2026-07-22T22:52:20.796269Z","steps":["trace[1040537459] 'agreement among raft nodes before linearized reading'  (duration: 437.917906ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:20.796314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:20.193421Z","time spent":"602.889003ms","remote":"127.0.0.1:50602","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-07-22T22:52:20.796325Z","caller":"traceutil/trace.go:171","msg":"trace[1742554095] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:24564; }","duration":"359.112335ms","start":"2026-07-22T22:52:20.43719Z","end":"2026-07-22T22:52:20.796303Z","steps":["trace[1742554095] 'agreement among raft nodes before linearized reading'  (duration: 358.93026ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:20.796317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.522201ms","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-07-22T22:52:20.79635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:20.358177Z","time spent":"438.160183ms","remote":"127.0.0.1:50336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-07-22T22:52:20.796384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:20.437143Z","time spent":"359.228018ms","remote":"127.0.0.1:55184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "}
{"level":"info","ts":"2026-07-22T22:52:20.796401Z","caller":"traceutil/trace.go:171","msg":"trace[1306825138] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24564; }","duration":"585.640994ms","start":"2026-07-22T22:52:20.210737Z","end":"2026-07-22T22:52:20.796378Z","steps":["trace[1306825138] 'agreement among raft nodes before linearized reading'  (duration: 585.388847ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:20.796415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.536624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-07-22T22:52:20.796448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:20.210721Z","time spent":"585.714806ms","remote":"127.0.0.1:50602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-07-22T22:52:20.796203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.214051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:52:20.796505Z","caller":"traceutil/trace.go:171","msg":"trace[1036096904] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24564; }","duration":"602.624716ms","start":"2026-07-22T22:52:20.193857Z","end":"2026-07-22T22:52:20.796481Z","steps":["trace[1036096904] 'agreement among raft nodes before linearized reading'  (duration: 602.283777ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:20.796544Z","caller":"traceutil/trace.go:171","msg":"trace[1167396782] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:24564; }","duration":"385.610392ms","start":"2026-07-22T22:52:20.410923Z","end":"2026-07-22T22:52:20.796534Z","steps":["trace[1167396782] 'agreement among raft nodes before linearized reading'  (duration: 385.20926ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:20.796567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:20.410897Z","time spent":"385.660793ms","remote":"127.0.0.1:46956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true "}
{"level":"warn","ts":"2026-07-22T22:52:20.796559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:20.193824Z","time spent":"602.722159ms","remote":"127.0.0.1:50602","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-07-22T22:52:20.800874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:20.346265Z","time spent":"454.571999ms","remote":"127.0.0.1:50602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:24507 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-07-22T22:52:21.189909Z","caller":"traceutil/trace.go:171","msg":"trace[1282512864] transaction","detail":"{read_only:false; response_revision:24568; number_of_response:1; }","duration":"154.535696ms","start":"2026-07-22T22:52:21.035344Z","end":"2026-07-22T22:52:21.18988Z","steps":["trace[1282512864] 'process raft request'  (duration: 96.225615ms)","trace[1282512864] 'compare'  (duration: 57.992033ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:52:21.561861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.039138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machines/\" range_end:\"/registry/cluster.x-k8s.io/machines0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:52:21.561956Z","caller":"traceutil/trace.go:171","msg":"trace[298460792] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machines/; range_end:/registry/cluster.x-k8s.io/machines0; response_count:0; response_revision:24568; }","duration":"106.175572ms","start":"2026-07-22T22:52:21.455754Z","end":"2026-07-22T22:52:21.56193Z","steps":["trace[298460792] 'count revisions from in-memory index tree'  (duration: 105.933896ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:21.867731Z","caller":"traceutil/trace.go:171","msg":"trace[6353446] transaction","detail":"{read_only:false; response_revision:24569; number_of_response:1; }","duration":"134.777358ms","start":"2026-07-22T22:52:21.732937Z","end":"2026-07-22T22:52:21.867714Z","steps":["trace[6353446] 'process raft request'  (duration: 134.660725ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:22.299832Z","caller":"traceutil/trace.go:171","msg":"trace[1941728645] linearizableReadLoop","detail":"{readStateIndex:25368; appliedIndex:25367; }","duration":"266.994264ms","start":"2026-07-22T22:52:22.032814Z","end":"2026-07-22T22:52:22.299809Z","steps":["trace[1941728645] 'read index received'  (duration: 266.808719ms)","trace[1941728645] 'applied index is now lower than readState.Index'  (duration: 184.645µs)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:52:22.300128Z","caller":"traceutil/trace.go:171","msg":"trace[1049586676] transaction","detail":"{read_only:false; response_revision:24570; number_of_response:1; }","duration":"267.823557ms","start":"2026-07-22T22:52:22.032288Z","end":"2026-07-22T22:52:22.300111Z","steps":["trace[1049586676] 'process raft request'  (duration: 267.396355ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:22.300453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.744449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:52:22.300504Z","caller":"traceutil/trace.go:171","msg":"trace[869739996] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24570; }","duration":"160.833492ms","start":"2026-07-22T22:52:22.139659Z","end":"2026-07-22T22:52:22.300492Z","steps":["trace[869739996] 'agreement among raft nodes before linearized reading'  (duration: 160.74207ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:22.300798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.989891ms","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-07-22T22:52:22.300851Z","caller":"traceutil/trace.go:171","msg":"trace[664162646] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24570; }","duration":"268.095795ms","start":"2026-07-22T22:52:22.03274Z","end":"2026-07-22T22:52:22.300835Z","steps":["trace[664162646] 'agreement among raft nodes before linearized reading'  (duration: 267.953331ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:22.588914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.714381ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249530096 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24555 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-22T22:52:22.588983Z","caller":"traceutil/trace.go:171","msg":"trace[1478379868] transaction","detail":"{read_only:false; response_revision:24571; number_of_response:1; }","duration":"283.821631ms","start":"2026-07-22T22:52:22.305149Z","end":"2026-07-22T22:52:22.588971Z","steps":["trace[1478379868] 'process raft request'  (duration: 137.998607ms)","trace[1478379868] 'compare'  (duration: 145.027922ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:52:22.59588Z","caller":"traceutil/trace.go:171","msg":"trace[984138212] transaction","detail":"{read_only:false; response_revision:24572; number_of_response:1; }","duration":"235.039556ms","start":"2026-07-22T22:52:22.36081Z","end":"2026-07-22T22:52:22.59585Z","steps":["trace[984138212] 'process raft request'  (duration: 234.791229ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:22.595906Z","caller":"traceutil/trace.go:171","msg":"trace[1045534800] linearizableReadLoop","detail":"{readStateIndex:25375; appliedIndex:25369; }","duration":"147.136582ms","start":"2026-07-22T22:52:22.448748Z","end":"2026-07-22T22:52:22.595885Z","steps":["trace[1045534800] 'read index received'  (duration: 146.795332ms)","trace[1045534800] 'applied index is now lower than readState.Index'  (duration: 340.53µs)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:52:22.596021Z","caller":"traceutil/trace.go:171","msg":"trace[1493348776] transaction","detail":"{read_only:false; response_revision:24573; number_of_response:1; }","duration":"234.978793ms","start":"2026-07-22T22:52:22.361032Z","end":"2026-07-22T22:52:22.596011Z","steps":["trace[1493348776] 'process raft request'  (duration: 234.696205ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:22.596174Z","caller":"traceutil/trace.go:171","msg":"trace[1949835644] transaction","detail":"{read_only:false; response_revision:24574; number_of_response:1; }","duration":"234.659405ms","start":"2026-07-22T22:52:22.361496Z","end":"2026-07-22T22:52:22.596155Z","steps":["trace[1949835644] 'process raft request'  (duration: 234.269734ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:22.596388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.606705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:52:22.596427Z","caller":"traceutil/trace.go:171","msg":"trace[945848981] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesets/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesets0; response_count:0; response_revision:24577; }","duration":"147.693346ms","start":"2026-07-22T22:52:22.448723Z","end":"2026-07-22T22:52:22.596416Z","steps":["trace[945848981] 'agreement among raft nodes before linearized reading'  (duration: 147.592064ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:22.596561Z","caller":"traceutil/trace.go:171","msg":"trace[632298978] transaction","detail":"{read_only:false; response_revision:24575; number_of_response:1; }","duration":"234.48102ms","start":"2026-07-22T22:52:22.362071Z","end":"2026-07-22T22:52:22.596552Z","steps":["trace[632298978] 'process raft request'  (duration: 233.725499ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:22.596693Z","caller":"traceutil/trace.go:171","msg":"trace[2014480546] transaction","detail":"{read_only:false; response_revision:24576; number_of_response:1; }","duration":"234.409378ms","start":"2026-07-22T22:52:22.362276Z","end":"2026-07-22T22:52:22.596685Z","steps":["trace[2014480546] 'process raft request'  (duration: 233.547074ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:22.596783Z","caller":"traceutil/trace.go:171","msg":"trace[1528805175] transaction","detail":"{read_only:false; response_revision:24577; number_of_response:1; }","duration":"233.532433ms","start":"2026-07-22T22:52:22.363243Z","end":"2026-07-22T22:52:22.596776Z","steps":["trace[1528805175] 'process raft request'  (duration: 232.608338ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:22.920612Z","caller":"traceutil/trace.go:171","msg":"trace[665297680] transaction","detail":"{read_only:false; response_revision:24579; number_of_response:1; }","duration":"110.079851ms","start":"2026-07-22T22:52:22.810504Z","end":"2026-07-22T22:52:22.920583Z","steps":["trace[665297680] 'process raft request'  (duration: 109.879565ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:23.197038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.252349ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249530111 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24565 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-22T22:52:23.197525Z","caller":"traceutil/trace.go:171","msg":"trace[1586134619] transaction","detail":"{read_only:false; response_revision:24580; number_of_response:1; }","duration":"271.746806ms","start":"2026-07-22T22:52:22.925682Z","end":"2026-07-22T22:52:23.197429Z","steps":["trace[1586134619] 'process raft request'  (duration: 125.998583ms)","trace[1586134619] 'compare'  (duration: 145.003482ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:52:23.272181Z","caller":"traceutil/trace.go:171","msg":"trace[337746422] transaction","detail":"{read_only:false; response_revision:24582; number_of_response:1; }","duration":"344.688594ms","start":"2026-07-22T22:52:22.927476Z","end":"2026-07-22T22:52:23.272165Z","steps":["trace[337746422] 'process raft request'  (duration: 344.659653ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:23.272282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:22.927464Z","time spent":"344.767086ms","remote":"127.0.0.1:50602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24567 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-07-22T22:52:23.272351Z","caller":"traceutil/trace.go:171","msg":"trace[1792635316] transaction","detail":"{read_only:false; response_revision:24581; number_of_response:1; }","duration":"346.513045ms","start":"2026-07-22T22:52:22.925833Z","end":"2026-07-22T22:52:23.272346Z","steps":["trace[1792635316] 'process raft request'  (duration: 346.220066ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:23.272379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:22.925813Z","time spent":"346.551436ms","remote":"127.0.0.1:50602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:24566 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-07-22T22:52:23.494836Z","caller":"traceutil/trace.go:171","msg":"trace[566813926] transaction","detail":"{read_only:false; response_revision:24583; number_of_response:1; }","duration":"366.796019ms","start":"2026-07-22T22:52:23.128022Z","end":"2026-07-22T22:52:23.494818Z","steps":["trace[566813926] 'process raft request'  (duration: 366.418258ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:23.494945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:23.127999Z","time spent":"366.889352ms","remote":"127.0.0.1:33642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418362,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" mod_revision:24025 > success:<request_put:<key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" value_size:418294 >> failure:<request_range:<key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" > >"}
{"level":"warn","ts":"2026-07-22T22:52:23.83671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.241799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1782"}
{"level":"info","ts":"2026-07-22T22:52:23.836814Z","caller":"traceutil/trace.go:171","msg":"trace[1651497722] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:24583; }","duration":"250.421923ms","start":"2026-07-22T22:52:23.586372Z","end":"2026-07-22T22:52:23.836794Z","steps":["trace[1651497722] 'range keys from in-memory index tree'  (duration: 250.059783ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:24.126982Z","caller":"traceutil/trace.go:171","msg":"trace[951411651] linearizableReadLoop","detail":"{readStateIndex:25382; appliedIndex:25381; }","duration":"255.272548ms","start":"2026-07-22T22:52:23.871689Z","end":"2026-07-22T22:52:24.126962Z","steps":["trace[951411651] 'read index received'  (duration: 255.086363ms)","trace[951411651] 'applied index is now lower than readState.Index'  (duration: 185.335µs)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:52:24.127269Z","caller":"traceutil/trace.go:171","msg":"trace[1203515070] transaction","detail":"{read_only:false; response_revision:24584; number_of_response:1; }","duration":"273.496944ms","start":"2026-07-22T22:52:23.853759Z","end":"2026-07-22T22:52:24.127256Z","steps":["trace[1203515070] 'process raft request'  (duration: 273.076693ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:24.127538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.846004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-07-22T22:52:24.127583Z","caller":"traceutil/trace.go:171","msg":"trace[605022065] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24584; }","duration":"255.939106ms","start":"2026-07-22T22:52:23.871633Z","end":"2026-07-22T22:52:24.127572Z","steps":["trace[605022065] 'agreement among raft nodes before linearized reading'  (duration: 255.791422ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:24.128016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.993386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-07-22T22:52:24.128063Z","caller":"traceutil/trace.go:171","msg":"trace[1953789082] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24584; }","duration":"234.067088ms","start":"2026-07-22T22:52:23.893985Z","end":"2026-07-22T22:52:24.128052Z","steps":["trace[1953789082] 'agreement among raft nodes before linearized reading'  (duration: 233.993345ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:24.128834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.052956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-07-22T22:52:24.128886Z","caller":"traceutil/trace.go:171","msg":"trace[1740112315] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24584; }","duration":"121.137309ms","start":"2026-07-22T22:52:24.007739Z","end":"2026-07-22T22:52:24.128876Z","steps":["trace[1740112315] 'agreement among raft nodes before linearized reading'  (duration: 121.002265ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:24.129082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.834749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:52:24.129123Z","caller":"traceutil/trace.go:171","msg":"trace[1139601363] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesets/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesets0; response_count:0; response_revision:24584; }","duration":"225.898071ms","start":"2026-07-22T22:52:23.903216Z","end":"2026-07-22T22:52:24.129114Z","steps":["trace[1139601363] 'agreement among raft nodes before linearized reading'  (duration: 225.835929ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:24.300859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.763437ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249530121 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:24569 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-22T22:52:24.301331Z","caller":"traceutil/trace.go:171","msg":"trace[1867475143] linearizableReadLoop","detail":"{readStateIndex:25383; appliedIndex:25382; }","duration":"167.330233ms","start":"2026-07-22T22:52:24.133929Z","end":"2026-07-22T22:52:24.301259Z","steps":["trace[1867475143] 'read index received'  (duration: 22.830025ms)","trace[1867475143] 'applied index is now lower than readState.Index'  (duration: 144.497748ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:52:24.301442Z","caller":"traceutil/trace.go:171","msg":"trace[153564238] transaction","detail":"{read_only:false; response_revision:24585; number_of_response:1; }","duration":"169.594636ms","start":"2026-07-22T22:52:24.131817Z","end":"2026-07-22T22:52:24.301412Z","steps":["trace[153564238] 'process raft request'  (duration: 24.984885ms)","trace[153564238] 'compare'  (duration: 143.49127ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:52:24.301732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.798655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-07-22T22:52:24.302081Z","caller":"traceutil/trace.go:171","msg":"trace[744621636] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24585; }","duration":"168.124645ms","start":"2026-07-22T22:52:24.133886Z","end":"2026-07-22T22:52:24.302011Z","steps":["trace[744621636] 'agreement among raft nodes before linearized reading'  (duration: 167.569899ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:24.30388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.919233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18433"}
{"level":"info","ts":"2026-07-22T22:52:24.304852Z","caller":"traceutil/trace.go:171","msg":"trace[1774553942] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24585; }","duration":"139.91555ms","start":"2026-07-22T22:52:24.164919Z","end":"2026-07-22T22:52:24.304834Z","steps":["trace[1774553942] 'agreement among raft nodes before linearized reading'  (duration: 138.728237ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:24.303942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.655466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:52:24.304976Z","caller":"traceutil/trace.go:171","msg":"trace[1720432641] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24585; }","duration":"166.929642ms","start":"2026-07-22T22:52:24.138034Z","end":"2026-07-22T22:52:24.304964Z","steps":["trace[1720432641] 'agreement among raft nodes before linearized reading'  (duration: 165.605765ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:24.78395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.049456ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249530126 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24570 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-22T22:52:24.784344Z","caller":"traceutil/trace.go:171","msg":"trace[529746434] transaction","detail":"{read_only:false; response_revision:24586; number_of_response:1; }","duration":"477.970429ms","start":"2026-07-22T22:52:24.306356Z","end":"2026-07-22T22:52:24.784326Z","steps":["trace[529746434] 'process raft request'  (duration: 128.464311ms)","trace[529746434] 'compare'  (duration: 348.927392ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:52:24.784443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:24.306334Z","time spent":"478.057502ms","remote":"127.0.0.1:50602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:24570 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:442 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"info","ts":"2026-07-22T22:52:24.784522Z","caller":"traceutil/trace.go:171","msg":"trace[1900381785] linearizableReadLoop","detail":"{readStateIndex:25384; appliedIndex:25383; }","duration":"474.986707ms","start":"2026-07-22T22:52:24.309506Z","end":"2026-07-22T22:52:24.784493Z","steps":["trace[1900381785] 'read index received'  (duration: 125.256343ms)","trace[1900381785] 'applied index is now lower than readState.Index'  (duration: 349.724544ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:52:24.784745Z","caller":"traceutil/trace.go:171","msg":"trace[481878755] transaction","detail":"{read_only:false; response_revision:24587; number_of_response:1; }","duration":"182.893946ms","start":"2026-07-22T22:52:24.601834Z","end":"2026-07-22T22:52:24.784728Z","steps":["trace[481878755] 'process raft request'  (duration: 182.526125ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:24.784862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.357997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18433"}
{"level":"info","ts":"2026-07-22T22:52:24.784905Z","caller":"traceutil/trace.go:171","msg":"trace[1260227934] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24587; }","duration":"475.430229ms","start":"2026-07-22T22:52:24.309464Z","end":"2026-07-22T22:52:24.784894Z","steps":["trace[1260227934] 'agreement among raft nodes before linearized reading'  (duration: 475.143241ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:24.784941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:24.309437Z","time spent":"475.496001ms","remote":"127.0.0.1:50518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18456,"request content":"key:\"/registry/minions/instance\" "}
{"level":"info","ts":"2026-07-22T22:52:24.861375Z","caller":"traceutil/trace.go:171","msg":"trace[1944565978] transaction","detail":"{read_only:false; response_revision:24588; number_of_response:1; }","duration":"259.446284ms","start":"2026-07-22T22:52:24.601912Z","end":"2026-07-22T22:52:24.861358Z","steps":["trace[1944565978] 'process raft request'  (duration: 259.324731ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:24.86166Z","caller":"traceutil/trace.go:171","msg":"trace[2113621585] transaction","detail":"{read_only:false; response_revision:24591; number_of_response:1; }","duration":"259.559877ms","start":"2026-07-22T22:52:24.602078Z","end":"2026-07-22T22:52:24.861638Z","steps":["trace[2113621585] 'process raft request'  (duration: 259.506876ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:24.86171Z","caller":"traceutil/trace.go:171","msg":"trace[400352588] transaction","detail":"{read_only:false; response_revision:24589; number_of_response:1; }","duration":"259.740842ms","start":"2026-07-22T22:52:24.601962Z","end":"2026-07-22T22:52:24.861703Z","steps":["trace[400352588] 'process raft request'  (duration: 259.366672ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:24.861766Z","caller":"traceutil/trace.go:171","msg":"trace[1665193557] transaction","detail":"{read_only:false; response_revision:24590; number_of_response:1; }","duration":"259.704192ms","start":"2026-07-22T22:52:24.602053Z","end":"2026-07-22T22:52:24.861757Z","steps":["trace[1665193557] 'process raft request'  (duration: 259.468325ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:24.861815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.2891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-07-22T22:52:24.861836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.771754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:52:24.861841Z","caller":"traceutil/trace.go:171","msg":"trace[1520718216] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:24592; }","duration":"309.350452ms","start":"2026-07-22T22:52:24.552482Z","end":"2026-07-22T22:52:24.861833Z","steps":["trace[1520718216] 'agreement among raft nodes before linearized reading'  (duration: 309.2854ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:24.86186Z","caller":"traceutil/trace.go:171","msg":"trace[1398499401] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:24592; }","duration":"149.807305ms","start":"2026-07-22T22:52:24.712043Z","end":"2026-07-22T22:52:24.861851Z","steps":["trace[1398499401] 'agreement among raft nodes before linearized reading'  (duration: 149.755074ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:24.861862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:24.552466Z","time spent":"309.390623ms","remote":"127.0.0.1:49456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true "}
{"level":"warn","ts":"2026-07-22T22:52:24.861903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.790866ms","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-07-22T22:52:24.86195Z","caller":"traceutil/trace.go:171","msg":"trace[123598215] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24592; }","duration":"472.878618ms","start":"2026-07-22T22:52:24.389058Z","end":"2026-07-22T22:52:24.861937Z","steps":["trace[123598215] 'agreement among raft nodes before linearized reading'  (duration: 472.800526ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:24.861975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:24.38904Z","time spent":"472.9308ms","remote":"127.0.0.1:50786","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-07-22T22:52:24.862035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.507474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-07-22T22:52:24.862058Z","caller":"traceutil/trace.go:171","msg":"trace[416268403] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24592; }","duration":"269.549065ms","start":"2026-07-22T22:52:24.592503Z","end":"2026-07-22T22:52:24.862052Z","steps":["trace[416268403] 'agreement among raft nodes before linearized reading'  (duration: 269.467332ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:24.862085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.811839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0\" ","response":"range_response_count:1 size:1860"}
{"level":"info","ts":"2026-07-22T22:52:24.862106Z","caller":"traceutil/trace.go:171","msg":"trace[185430036] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0; range_end:; response_count:1; response_revision:24592; }","duration":"302.846031ms","start":"2026-07-22T22:52:24.559254Z","end":"2026-07-22T22:52:24.8621Z","steps":["trace[185430036] 'agreement among raft nodes before linearized reading'  (duration: 302.764039ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:24.861955Z","caller":"traceutil/trace.go:171","msg":"trace[1596513087] transaction","detail":"{read_only:false; response_revision:24592; number_of_response:1; }","duration":"259.848846ms","start":"2026-07-22T22:52:24.602101Z","end":"2026-07-22T22:52:24.86195Z","steps":["trace[1596513087] 'process raft request'  (duration: 259.510826ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:24.86212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:24.559247Z","time spent":"302.869731ms","remote":"127.0.0.1:50500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1883,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0\" "}
{"level":"warn","ts":"2026-07-22T22:52:25.175422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.890202ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249530138 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:24571 > 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:18"}
{"level":"info","ts":"2026-07-22T22:52:25.175522Z","caller":"traceutil/trace.go:171","msg":"trace[1077323552] linearizableReadLoop","detail":"{readStateIndex:25391; appliedIndex:25390; }","duration":"309.355622ms","start":"2026-07-22T22:52:24.866149Z","end":"2026-07-22T22:52:25.175504Z","steps":["trace[1077323552] 'read index received'  (duration: 33.380189ms)","trace[1077323552] 'applied index is now lower than readState.Index'  (duration: 275.974043ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:52:25.175558Z","caller":"traceutil/trace.go:171","msg":"trace[104133105] transaction","detail":"{read_only:false; response_revision:24593; number_of_response:1; }","duration":"309.669941ms","start":"2026-07-22T22:52:24.865845Z","end":"2026-07-22T22:52:25.175515Z","steps":["trace[104133105] 'process raft request'  (duration: 33.607734ms)","trace[104133105] 'compare'  (duration: 275.595574ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:52:25.175628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.470296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:52:25.175661Z","caller":"traceutil/trace.go:171","msg":"trace[957938055] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:24593; }","duration":"309.511306ms","start":"2026-07-22T22:52:24.866138Z","end":"2026-07-22T22:52:25.175649Z","steps":["trace[957938055] 'agreement among raft nodes before linearized reading'  (duration: 309.448355ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:25.175694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:24.866132Z","time spent":"309.553917ms","remote":"127.0.0.1:50534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "}
{"level":"warn","ts":"2026-07-22T22:52:25.175735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:24.865825Z","time spent":"309.813365ms","remote":"127.0.0.1:50602","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:24571 > 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":"warn","ts":"2026-07-22T22:52:25.175755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.56634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-07-22T22:52:25.175809Z","caller":"traceutil/trace.go:171","msg":"trace[515542262] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24593; }","duration":"308.629041ms","start":"2026-07-22T22:52:24.867164Z","end":"2026-07-22T22:52:25.175793Z","steps":["trace[515542262] 'agreement among raft nodes before linearized reading'  (duration: 308.471007ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:25.175846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-22T22:52:24.86716Z","time spent":"308.679013ms","remote":"127.0.0.1:50528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-07-22T22:52:25.176018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.62452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/projects/\" range_end:\"/registry/openstack.k-orc.cloud/projects0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:52:25.176052Z","caller":"traceutil/trace.go:171","msg":"trace[417756974] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/projects/; range_end:/registry/openstack.k-orc.cloud/projects0; response_count:0; response_revision:24593; }","duration":"263.683432ms","start":"2026-07-22T22:52:24.912356Z","end":"2026-07-22T22:52:25.176039Z","steps":["trace[417756974] 'agreement among raft nodes before linearized reading'  (duration: 263.631131ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:25.176052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.647066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-07-22T22:52:25.176087Z","caller":"traceutil/trace.go:171","msg":"trace[1628861576] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24593; }","duration":"247.702327ms","start":"2026-07-22T22:52:24.928374Z","end":"2026-07-22T22:52:25.176076Z","steps":["trace[1628861576] 'agreement among raft nodes before linearized reading'  (duration: 247.578944ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:25.476166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.664958ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249530145 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:24580 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-22T22:52:25.476328Z","caller":"traceutil/trace.go:171","msg":"trace[1193117525] linearizableReadLoop","detail":"{readStateIndex:25393; appliedIndex:25392; }","duration":"210.537405ms","start":"2026-07-22T22:52:25.265746Z","end":"2026-07-22T22:52:25.476283Z","steps":["trace[1193117525] 'read index received'  (duration: 67.266401ms)","trace[1193117525] 'applied index is now lower than readState.Index'  (duration: 143.269053ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:52:25.476457Z","caller":"traceutil/trace.go:171","msg":"trace[305679803] transaction","detail":"{read_only:false; response_revision:24595; number_of_response:1; }","duration":"212.938791ms","start":"2026-07-22T22:52:25.263505Z","end":"2026-07-22T22:52:25.476443Z","steps":["trace[305679803] 'process raft request'  (duration: 69.689678ms)","trace[305679803] 'compare'  (duration: 141.70445ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:52:25.476764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.99054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-07-22T22:52:25.476786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.010758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-22T22:52:25.476833Z","caller":"traceutil/trace.go:171","msg":"trace[1828567258] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24595; }","duration":"187.109062ms","start":"2026-07-22T22:52:25.28971Z","end":"2026-07-22T22:52:25.476819Z","steps":["trace[1828567258] 'agreement among raft nodes before linearized reading'  (duration: 186.938178ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:25.476889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.395717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-07-22T22:52:25.476882Z","caller":"traceutil/trace.go:171","msg":"trace[477862182] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:24595; }","duration":"211.12863ms","start":"2026-07-22T22:52:25.265726Z","end":"2026-07-22T22:52:25.476854Z","steps":["trace[477862182] 'agreement among raft nodes before linearized reading'  (duration: 210.943805ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:25.476955Z","caller":"traceutil/trace.go:171","msg":"trace[2029645146] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24595; }","duration":"198.465279ms","start":"2026-07-22T22:52:25.27847Z","end":"2026-07-22T22:52:25.476935Z","steps":["trace[2029645146] 'agreement among raft nodes before linearized reading'  (duration: 198.342185ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:25.476753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.696703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-07-22T22:52:25.47709Z","caller":"traceutil/trace.go:171","msg":"trace[1376354492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24595; }","duration":"200.135275ms","start":"2026-07-22T22:52:25.276949Z","end":"2026-07-22T22:52:25.477084Z","steps":["trace[1376354492] 'agreement among raft nodes before linearized reading'  (duration: 199.568949ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:25.766156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.68626ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249530148 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:24582 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-22T22:52:25.766301Z","caller":"traceutil/trace.go:171","msg":"trace[2077355365] transaction","detail":"{read_only:false; response_revision:24597; number_of_response:1; }","duration":"284.756728ms","start":"2026-07-22T22:52:25.481532Z","end":"2026-07-22T22:52:25.766289Z","steps":["trace[2077355365] 'process raft request'  (duration: 284.702427ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:25.766373Z","caller":"traceutil/trace.go:171","msg":"trace[61314204] transaction","detail":"{read_only:false; response_revision:24596; number_of_response:1; }","duration":"284.818949ms","start":"2026-07-22T22:52:25.48152Z","end":"2026-07-22T22:52:25.766339Z","steps":["trace[61314204] 'process raft request'  (duration: 138.886922ms)","trace[61314204] 'compare'  (duration: 145.599538ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:52:26.046868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.5601ms","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:6"}
{"level":"info","ts":"2026-07-22T22:52:26.046944Z","caller":"traceutil/trace.go:171","msg":"trace[1947264326] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:24597; }","duration":"135.688033ms","start":"2026-07-22T22:52:25.911238Z","end":"2026-07-22T22:52:26.046926Z","steps":["trace[1947264326] 'count revisions from in-memory index tree'  (duration: 135.470437ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:52:26.428678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.004866ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10125956235249530153 > lease_revoke:<id:0c869f8bdd33342a>","response":"size:29"}
{"level":"info","ts":"2026-07-22T22:52:26.428798Z","caller":"traceutil/trace.go:171","msg":"trace[714181915] linearizableReadLoop","detail":"{readStateIndex:25396; appliedIndex:25395; }","duration":"116.977222ms","start":"2026-07-22T22:52:26.311799Z","end":"2026-07-22T22:52:26.428776Z","steps":["trace[714181915] 'read index received'  (duration: 51.471µs)","trace[714181915] 'applied index is now lower than readState.Index'  (duration: 116.923751ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:52:26.429011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.190188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-07-22T22:52:26.429131Z","caller":"traceutil/trace.go:171","msg":"trace[73214306] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24597; }","duration":"117.359433ms","start":"2026-07-22T22:52:26.311744Z","end":"2026-07-22T22:52:26.429103Z","steps":["trace[73214306] 'agreement among raft nodes before linearized reading'  (duration: 117.089445ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:27.014486Z","caller":"traceutil/trace.go:171","msg":"trace[357340419] transaction","detail":"{read_only:false; response_revision:24602; number_of_response:1; }","duration":"148.387186ms","start":"2026-07-22T22:52:26.86607Z","end":"2026-07-22T22:52:27.014457Z","steps":["trace[357340419] 'process raft request'  (duration: 146.595166ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:27.014566Z","caller":"traceutil/trace.go:171","msg":"trace[1452141307] transaction","detail":"{read_only:false; response_revision:24604; number_of_response:1; }","duration":"147.453121ms","start":"2026-07-22T22:52:26.867082Z","end":"2026-07-22T22:52:27.014536Z","steps":["trace[1452141307] 'process raft request'  (duration: 147.357348ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:27.014611Z","caller":"traceutil/trace.go:171","msg":"trace[1637123394] transaction","detail":"{read_only:false; response_revision:24605; number_of_response:1; }","duration":"147.348717ms","start":"2026-07-22T22:52:26.867241Z","end":"2026-07-22T22:52:27.01459Z","steps":["trace[1637123394] 'process raft request'  (duration: 147.253155ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:52:27.014789Z","caller":"traceutil/trace.go:171","msg":"trace[593181169] transaction","detail":"{read_only:false; response_revision:24603; number_of_response:1; }","duration":"147.921503ms","start":"2026-07-22T22:52:26.86682Z","end":"2026-07-22T22:52:27.014742Z","steps":["trace[593181169] 'process raft request'  (duration: 147.577464ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:53:51.549611Z","caller":"traceutil/trace.go:171","msg":"trace[1231440884] transaction","detail":"{read_only:false; response_revision:25460; number_of_response:1; }","duration":"107.671644ms","start":"2026-07-22T22:53:51.441919Z","end":"2026-07-22T22:53:51.549591Z","steps":["trace[1231440884] 'process raft request'  (duration: 107.509919ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:53:51.576444Z","caller":"traceutil/trace.go:171","msg":"trace[1741152063] transaction","detail":"{read_only:false; response_revision:25461; number_of_response:1; }","duration":"123.585546ms","start":"2026-07-22T22:53:51.452831Z","end":"2026-07-22T22:53:51.576416Z","steps":["trace[1741152063] 'process raft request'  (duration: 123.388311ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:53:51.761614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.853995ms","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-07-22T22:53:51.76171Z","caller":"traceutil/trace.go:171","msg":"trace[54280487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25463; }","duration":"136.984349ms","start":"2026-07-22T22:53:51.624691Z","end":"2026-07-22T22:53:51.761675Z","steps":["trace[54280487] 'range keys from in-memory index tree'  (duration: 136.617319ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:54:22.985101Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000067d5.wal"}
{"level":"info","ts":"2026-07-22T22:55:33.901507Z","caller":"traceutil/trace.go:171","msg":"trace[576835346] linearizableReadLoop","detail":"{readStateIndex:27366; appliedIndex:27365; }","duration":"124.207054ms","start":"2026-07-22T22:55:33.777277Z","end":"2026-07-22T22:55:33.901484Z","steps":["trace[576835346] 'read index received'  (duration: 60.265286ms)","trace[576835346] 'applied index is now lower than readState.Index'  (duration: 63.940748ms)"],"step_count":2}
{"level":"info","ts":"2026-07-22T22:55:33.901673Z","caller":"traceutil/trace.go:171","msg":"trace[1337615083] transaction","detail":"{read_only:false; response_revision:26522; number_of_response:1; }","duration":"148.254833ms","start":"2026-07-22T22:55:33.753404Z","end":"2026-07-22T22:55:33.901659Z","steps":["trace[1337615083] 'process raft request'  (duration: 84.263624ms)","trace[1337615083] 'compare'  (duration: 63.704261ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-22T22:55:33.901914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.423488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/rook-ceph/rook-ceph-operator-config\" ","response":"range_response_count:1 size:6825"}
{"level":"info","ts":"2026-07-22T22:55:33.90198Z","caller":"traceutil/trace.go:171","msg":"trace[1007690994] range","detail":"{range_begin:/registry/configmaps/rook-ceph/rook-ceph-operator-config; range_end:; response_count:1; response_revision:26522; }","duration":"120.527371ms","start":"2026-07-22T22:55:33.781439Z","end":"2026-07-22T22:55:33.901966Z","steps":["trace[1007690994] 'agreement among raft nodes before linearized reading'  (duration: 120.306935ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-22T22:55:33.903359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.137393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-07-22T22:55:33.903442Z","caller":"traceutil/trace.go:171","msg":"trace[1687067133] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:26522; }","duration":"169.276117ms","start":"2026-07-22T22:55:33.734149Z","end":"2026-07-22T22:55:33.903425Z","steps":["trace[1687067133] 'agreement among raft nodes before linearized reading'  (duration: 167.871228ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T22:55:57.959057Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23717}
{"level":"info","ts":"2026-07-22T22:55:58.095815Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23717,"took":"131.96829ms","hash":3055984759,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":38912000,"current-db-size-in-use":"39 MB"}
{"level":"info","ts":"2026-07-22T22:55:58.095889Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3055984759,"revision":23717,"compact-revision":20466}
{"level":"info","ts":"2026-07-22T23:00:53.182681Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"51a5c416a4d98c86","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-22T23:00:53.187669Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-07-22T23:00:53.187732Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-07-22T23:00:57.967349Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26804}
{"level":"info","ts":"2026-07-22T23:00:58.11083Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26804,"took":"140.000252ms","hash":3978136457,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":31543296,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-07-22T23:00:58.110898Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3978136457,"revision":26804,"compact-revision":23717}
{"level":"info","ts":"2026-07-22T23:02:16.868243Z","caller":"traceutil/trace.go:171","msg":"trace[514105471] transaction","detail":"{read_only:false; response_revision:29689; number_of_response:1; }","duration":"240.381172ms","start":"2026-07-22T23:02:16.627842Z","end":"2026-07-22T23:02:16.868223Z","steps":["trace[514105471] 'process raft request'  (duration: 240.251289ms)"],"step_count":1}
{"level":"info","ts":"2026-07-22T23:05:57.973796Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":29118}
{"level":"info","ts":"2026-07-22T23:05:58.100422Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":29118,"took":"123.153804ms","hash":3039455272,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":30232576,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-07-22T23:05:58.100499Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3039455272,"revision":29118,"compact-revision":26804}
{"level":"info","ts":"2026-07-22T23:10:57.980381Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31367}
{"level":"info","ts":"2026-07-22T23:10:58.116881Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31367,"took":"133.201653ms","hash":3528762530,"current-db-size-bytes":58290176,"current-db-size":"58 MB","current-db-size-in-use-bytes":30773248,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-07-22T23:10:58.11696Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3528762530,"revision":31367,"compact-revision":29118}
{"level":"info","ts":"2026-07-22T23:15:57.988323Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33702}
{"level":"info","ts":"2026-07-22T23:15:58.159386Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33702,"took":"167.662311ms","hash":1873157683,"current-db-size-bytes":59334656,"current-db-size":"59 MB","current-db-size-in-use-bytes":32247808,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-07-22T23:15:58.159467Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1873157683,"revision":33702,"compact-revision":31367}
{"level":"info","ts":"2026-07-22T23:20:57.994682Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35929}
{"level":"info","ts":"2026-07-22T23:20:58.134675Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35929,"took":"136.66835ms","hash":2498316091,"current-db-size-bytes":59809792,"current-db-size":"60 MB","current-db-size-in-use-bytes":31207424,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-07-22T23:20:58.134745Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2498316091,"revision":35929,"compact-revision":33702}
{"level":"info","ts":"2026-07-22T23:22:19.489958Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"51a5c416a4d98c86","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-22T23:22:19.494085Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-07-22T23:22:19.494228Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}