{"level":"warn","ts":"2026-08-19T20:28:40.778449Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-19T20:28:40.778607Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.78: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.19.213.78:2380","--initial-cluster=instance=https://199.19.213.78:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.78:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.78: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-08-19T20:28:40.778749Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-19T20:28:40.778766Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.78:2380"]}
{"level":"info","ts":"2026-08-19T20:28:40.778792Z","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-08-19T20:28:40.779896Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.78:2379"]}
{"level":"info","ts":"2026-08-19T20:28:40.780005Z","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.19.213.78:2380"],"listen-peer-urls":["https://199.19.213.78:2380"],"advertise-client-urls":["https://199.19.213.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.78: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-08-19T20:28:40.799399Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"19.023917ms"}
{"level":"info","ts":"2026-08-19T20:28:40.868273Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"173f1df9994fe3b5","cluster-id":"f38512da1b70c9fc"}
{"level":"info","ts":"2026-08-19T20:28:40.868469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 switched to configuration voters=()"}
{"level":"info","ts":"2026-08-19T20:28:40.86851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 became follower at term 0"}
{"level":"info","ts":"2026-08-19T20:28:40.86853Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 173f1df9994fe3b5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-19T20:28:40.868553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 became follower at term 1"}
{"level":"info","ts":"2026-08-19T20:28:40.868622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 switched to configuration voters=(1675090544261325749)"}
{"level":"warn","ts":"2026-08-19T20:28:40.92582Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-19T20:28:40.935148Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-19T20:28:40.940979Z","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-08-19T20:28:40.944774Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"173f1df9994fe3b5","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-19T20:28:40.944951Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"173f1df9994fe3b5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-19T20:28:40.945077Z","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-08-19T20:28:40.945176Z","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-08-19T20:28:40.945192Z","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-08-19T20:28:40.9461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 switched to configuration voters=(1675090544261325749)"}
{"level":"info","ts":"2026-08-19T20:28:40.946343Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f38512da1b70c9fc","local-member-id":"173f1df9994fe3b5","added-peer-id":"173f1df9994fe3b5","added-peer-peer-urls":["https://199.19.213.78:2380"]}
{"level":"info","ts":"2026-08-19T20:28:40.949291Z","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-08-19T20:28:40.949569Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"173f1df9994fe3b5","initial-advertise-peer-urls":["https://199.19.213.78:2380"],"listen-peer-urls":["https://199.19.213.78:2380"],"advertise-client-urls":["https://199.19.213.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-19T20:28:40.949535Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.78:2380"}
{"level":"info","ts":"2026-08-19T20:28:40.949641Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-19T20:28:40.94966Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.78:2380"}
{"level":"info","ts":"2026-08-19T20:28:41.369045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 is starting a new election at term 1"}
{"level":"info","ts":"2026-08-19T20:28:41.3691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-19T20:28:41.369136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 received MsgPreVoteResp from 173f1df9994fe3b5 at term 1"}
{"level":"info","ts":"2026-08-19T20:28:41.369149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 became candidate at term 2"}
{"level":"info","ts":"2026-08-19T20:28:41.369154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 received MsgVoteResp from 173f1df9994fe3b5 at term 2"}
{"level":"info","ts":"2026-08-19T20:28:41.369163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"173f1df9994fe3b5 became leader at term 2"}
{"level":"info","ts":"2026-08-19T20:28:41.369172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 173f1df9994fe3b5 elected leader 173f1df9994fe3b5 at term 2"}
{"level":"info","ts":"2026-08-19T20:28:41.373863Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"173f1df9994fe3b5","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.78:2379]}","request-path":"/0/members/173f1df9994fe3b5/attributes","cluster-id":"f38512da1b70c9fc","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-19T20:28:41.374127Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T20:28:41.374247Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-19T20:28:41.374302Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-19T20:28:41.374549Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-19T20:28:41.374657Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-19T20:28:41.376605Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f38512da1b70c9fc","local-member-id":"173f1df9994fe3b5","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T20:28:41.376732Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T20:28:41.376769Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T20:28:41.376766Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.78:2379"}
{"level":"info","ts":"2026-08-19T20:28:41.378487Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-19T20:28:57.266116Z","caller":"traceutil/trace.go:171","msg":"trace[1843385300] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"200.0985ms","start":"2026-08-19T20:28:57.06599Z","end":"2026-08-19T20:28:57.266089Z","steps":["trace[1843385300] 'process raft request'  (duration: 199.959837ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:29:26.334811Z","caller":"traceutil/trace.go:171","msg":"trace[1552193169] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"175.721323ms","start":"2026-08-19T20:29:26.159052Z","end":"2026-08-19T20:29:26.334773Z","steps":["trace[1552193169] 'process raft request'  (duration: 146.460921ms)","trace[1552193169] 'compare'  (duration: 28.828102ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:29:26.581757Z","caller":"traceutil/trace.go:171","msg":"trace[1836118651] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"102.811839ms","start":"2026-08-19T20:29:26.478912Z","end":"2026-08-19T20:29:26.581724Z","steps":["trace[1836118651] 'read index received'  (duration: 49.774472ms)","trace[1836118651] 'applied index is now lower than readState.Index'  (duration: 53.035907ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:29:26.581889Z","caller":"traceutil/trace.go:171","msg":"trace[1203233887] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"230.795705ms","start":"2026-08-19T20:29:26.35105Z","end":"2026-08-19T20:29:26.581846Z","steps":["trace[1203233887] 'process raft request'  (duration: 177.642295ms)","trace[1203233887] 'compare'  (duration: 52.837013ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:29:26.581967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.024804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-08-19T20:29:26.58228Z","caller":"traceutil/trace.go:171","msg":"trace[1955372517] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:629; }","duration":"103.411333ms","start":"2026-08-19T20:29:26.478849Z","end":"2026-08-19T20:29:26.58226Z","steps":["trace[1955372517] 'agreement among raft nodes before linearized reading'  (duration: 103.024845ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:29:26.582451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.441483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-08-19T20:29:26.582533Z","caller":"traceutil/trace.go:171","msg":"trace[505865012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:629; }","duration":"103.599847ms","start":"2026-08-19T20:29:26.478911Z","end":"2026-08-19T20:29:26.582511Z","steps":["trace[505865012] 'agreement among raft nodes before linearized reading'  (duration: 103.390882ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:29:27.179989Z","caller":"traceutil/trace.go:171","msg":"trace[834924157] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"439.357991ms","start":"2026-08-19T20:29:26.740585Z","end":"2026-08-19T20:29:27.179943Z","steps":["trace[834924157] 'process raft request'  (duration: 438.750457ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:29:27.180109Z","caller":"traceutil/trace.go:171","msg":"trace[1913909255] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"221.03029ms","start":"2026-08-19T20:29:26.959028Z","end":"2026-08-19T20:29:27.180058Z","steps":["trace[1913909255] 'read index received'  (duration: 220.186961ms)","trace[1913909255] 'applied index is now lower than readState.Index'  (duration: 839.729µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:29:27.180008Z","caller":"traceutil/trace.go:171","msg":"trace[1447709818] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"183.637804ms","start":"2026-08-19T20:29:26.996346Z","end":"2026-08-19T20:29:27.179984Z","steps":["trace[1447709818] 'process raft request'  (duration: 183.576552ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:29:27.180315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.271727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:29:27.180378Z","caller":"traceutil/trace.go:171","msg":"trace[556633226] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"221.39206ms","start":"2026-08-19T20:29:26.958966Z","end":"2026-08-19T20:29:27.180358Z","steps":["trace[556633226] 'agreement among raft nodes before linearized reading'  (duration: 221.260496ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:29:27.180987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:29:26.740546Z","time spent":"439.549155ms","remote":"127.0.0.1:43794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036161,"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:627 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036077 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-08-19T20:30:09.112493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.671578ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16408196858275704223 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1181 > 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-08-19T20:30:09.112742Z","caller":"traceutil/trace.go:171","msg":"trace[1624568225] linearizableReadLoop","detail":"{readStateIndex:1230; appliedIndex:1229; }","duration":"154.738237ms","start":"2026-08-19T20:30:08.957979Z","end":"2026-08-19T20:30:09.112718Z","steps":["trace[1624568225] 'read index received'  (duration: 33.041µs)","trace[1624568225] 'applied index is now lower than readState.Index'  (duration: 154.702846ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:30:09.112845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.868521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:30:09.112879Z","caller":"traceutil/trace.go:171","msg":"trace[1432098503] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1193; }","duration":"154.937432ms","start":"2026-08-19T20:30:08.957931Z","end":"2026-08-19T20:30:09.112869Z","steps":["trace[1432098503] 'agreement among raft nodes before linearized reading'  (duration: 154.85618ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:30:09.113044Z","caller":"traceutil/trace.go:171","msg":"trace[764529998] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"247.239046ms","start":"2026-08-19T20:30:08.865753Z","end":"2026-08-19T20:30:09.112992Z","steps":["trace[764529998] 'process raft request'  (duration: 80.659246ms)","trace[764529998] 'compare'  (duration: 165.36376ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:30:53.27827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.955971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-08-19T20:30:53.278451Z","caller":"traceutil/trace.go:171","msg":"trace[1413649747] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1842; }","duration":"219.187627ms","start":"2026-08-19T20:30:53.059241Z","end":"2026-08-19T20:30:53.278429Z","steps":["trace[1413649747] 'range keys from in-memory index tree'  (duration: 218.782936ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:53.278437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.116174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-08-19T20:30:53.27856Z","caller":"traceutil/trace.go:171","msg":"trace[395154018] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1842; }","duration":"212.33854ms","start":"2026-08-19T20:30:53.066193Z","end":"2026-08-19T20:30:53.278532Z","steps":["trace[395154018] 'range keys from in-memory index tree'  (duration: 211.854138ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:30:53.373451Z","caller":"traceutil/trace.go:171","msg":"trace[1153146456] linearizableReadLoop","detail":"{readStateIndex:1918; appliedIndex:1917; }","duration":"106.576179ms","start":"2026-08-19T20:30:53.266844Z","end":"2026-08-19T20:30:53.37342Z","steps":["trace[1153146456] 'read index received'  (duration: 106.319983ms)","trace[1153146456] 'applied index is now lower than readState.Index'  (duration: 254.466µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:30:53.373529Z","caller":"traceutil/trace.go:171","msg":"trace[1977723860] transaction","detail":"{read_only:false; response_revision:1843; number_of_response:1; }","duration":"113.13535ms","start":"2026-08-19T20:30:53.260358Z","end":"2026-08-19T20:30:53.373493Z","steps":["trace[1977723860] 'process raft request'  (duration: 112.839903ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:53.373855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.978649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-08-19T20:30:53.37394Z","caller":"traceutil/trace.go:171","msg":"trace[387910040] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1843; }","duration":"107.130613ms","start":"2026-08-19T20:30:53.26679Z","end":"2026-08-19T20:30:53.37392Z","steps":["trace[387910040] 'agreement among raft nodes before linearized reading'  (duration: 106.772365ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:30:53.432501Z","caller":"traceutil/trace.go:171","msg":"trace[914325043] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"150.265775ms","start":"2026-08-19T20:30:53.282208Z","end":"2026-08-19T20:30:53.432474Z","steps":["trace[914325043] 'process raft request'  (duration: 127.698005ms)","trace[914325043] 'compare'  (duration: 22.371246ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:30:53.432673Z","caller":"traceutil/trace.go:171","msg":"trace[909849706] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"149.979208ms","start":"2026-08-19T20:30:53.282662Z","end":"2026-08-19T20:30:53.432641Z","steps":["trace[909849706] 'process raft request'  (duration: 149.767043ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:30:53.844491Z","caller":"traceutil/trace.go:171","msg":"trace[322902638] linearizableReadLoop","detail":"{readStateIndex:1921; appliedIndex:1920; }","duration":"116.075611ms","start":"2026-08-19T20:30:53.728388Z","end":"2026-08-19T20:30:53.844463Z","steps":["trace[322902638] 'read index received'  (duration: 115.890847ms)","trace[322902638] 'applied index is now lower than readState.Index'  (duration: 183.724µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:30:53.844554Z","caller":"traceutil/trace.go:171","msg":"trace[1229327940] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"125.684605ms","start":"2026-08-19T20:30:53.718824Z","end":"2026-08-19T20:30:53.844509Z","steps":["trace[1229327940] 'process raft request'  (duration: 125.486351ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:30:53.844705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.305627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-65276e37-1bb8-452e-bbbd-e536f79096aa\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-08-19T20:30:53.844752Z","caller":"traceutil/trace.go:171","msg":"trace[650974952] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-65276e37-1bb8-452e-bbbd-e536f79096aa; range_end:; response_count:1; response_revision:1846; }","duration":"116.4077ms","start":"2026-08-19T20:30:53.728329Z","end":"2026-08-19T20:30:53.844737Z","steps":["trace[650974952] 'agreement among raft nodes before linearized reading'  (duration: 116.235236ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:31:07.061456Z","caller":"traceutil/trace.go:171","msg":"trace[2071432216] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"194.183317ms","start":"2026-08-19T20:31:06.867235Z","end":"2026-08-19T20:31:07.061418Z","steps":["trace[2071432216] 'process raft request'  (duration: 193.979272ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:31:38.662472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.240299ms","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-08-19T20:31:38.662604Z","caller":"traceutil/trace.go:171","msg":"trace[693702757] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2146; }","duration":"208.421723ms","start":"2026-08-19T20:31:38.454156Z","end":"2026-08-19T20:31:38.662578Z","steps":["trace[693702757] 'range keys from in-memory index tree'  (duration: 208.051735ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:31:38.793594Z","caller":"traceutil/trace.go:171","msg":"trace[428968619] linearizableReadLoop","detail":"{readStateIndex:2232; appliedIndex:2231; }","duration":"108.062186ms","start":"2026-08-19T20:31:38.685504Z","end":"2026-08-19T20:31:38.793567Z","steps":["trace[428968619] 'read index received'  (duration: 107.850191ms)","trace[428968619] 'applied index is now lower than readState.Index'  (duration: 210.925µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:31:38.793741Z","caller":"traceutil/trace.go:171","msg":"trace[1142987331] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"127.061559ms","start":"2026-08-19T20:31:38.66664Z","end":"2026-08-19T20:31:38.793701Z","steps":["trace[1142987331] 'process raft request'  (duration: 126.728371ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:31:38.793852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.331052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-08-19T20:31:38.793893Z","caller":"traceutil/trace.go:171","msg":"trace[514272646] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2147; }","duration":"108.423814ms","start":"2026-08-19T20:31:38.685458Z","end":"2026-08-19T20:31:38.793882Z","steps":["trace[514272646] 'agreement among raft nodes before linearized reading'  (duration: 108.2306ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:33:07.618541Z","caller":"traceutil/trace.go:171","msg":"trace[1904542577] transaction","detail":"{read_only:false; response_revision:2819; number_of_response:1; }","duration":"214.705717ms","start":"2026-08-19T20:33:07.403464Z","end":"2026-08-19T20:33:07.61817Z","steps":["trace[1904542577] 'process raft request'  (duration: 153.192659ms)","trace[1904542577] 'compare'  (duration: 61.128477ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:35:37.718507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.6535ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:35:37.718731Z","caller":"traceutil/trace.go:171","msg":"trace[961977546] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:3814; }","duration":"120.914097ms","start":"2026-08-19T20:35:37.597783Z","end":"2026-08-19T20:35:37.718697Z","steps":["trace[961977546] 'range keys from in-memory index tree'  (duration: 120.616279ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:35:43.074667Z","caller":"traceutil/trace.go:171","msg":"trace[1839205472] transaction","detail":"{read_only:false; response_revision:3841; number_of_response:1; }","duration":"113.897375ms","start":"2026-08-19T20:35:42.960733Z","end":"2026-08-19T20:35:43.07463Z","steps":["trace[1839205472] 'process raft request'  (duration: 86.308149ms)","trace[1839205472] 'compare'  (duration: 27.419522ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:37:01.854731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.722372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/kube-system/kube-prometheus-stack-kubelet\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:37:01.854859Z","caller":"traceutil/trace.go:171","msg":"trace[1760117423] range","detail":"{range_begin:/registry/services/specs/kube-system/kube-prometheus-stack-kubelet; range_end:; response_count:0; response_revision:4717; }","duration":"133.947027ms","start":"2026-08-19T20:37:01.720883Z","end":"2026-08-19T20:37:01.85483Z","steps":["trace[1760117423] 'range keys from in-memory index tree'  (duration: 133.614299ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:37:07.165674Z","caller":"traceutil/trace.go:171","msg":"trace[587585643] transaction","detail":"{read_only:false; response_revision:4887; number_of_response:1; }","duration":"114.804025ms","start":"2026-08-19T20:37:07.050826Z","end":"2026-08-19T20:37:07.16563Z","steps":["trace[587585643] 'process raft request'  (duration: 27.479964ms)","trace[587585643] 'compare'  (duration: 86.937842ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:37:10.887404Z","caller":"traceutil/trace.go:171","msg":"trace[378983293] linearizableReadLoop","detail":"{readStateIndex:5218; appliedIndex:5217; }","duration":"103.520932ms","start":"2026-08-19T20:37:10.783851Z","end":"2026-08-19T20:37:10.887372Z","steps":["trace[378983293] 'read index received'  (duration: 103.291017ms)","trace[378983293] 'applied index is now lower than readState.Index'  (duration: 228.445µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:37:10.887535Z","caller":"traceutil/trace.go:171","msg":"trace[1371993175] transaction","detail":"{read_only:false; response_revision:5024; number_of_response:1; }","duration":"119.687464ms","start":"2026-08-19T20:37:10.767797Z","end":"2026-08-19T20:37:10.887485Z","steps":["trace[1371993175] 'process raft request'  (duration: 119.370616ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:37:10.887673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.800819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-741fbcae-5b2b-4e8a-b653-d383946aa740\" ","response":"range_response_count:1 size:3600"}
{"level":"info","ts":"2026-08-19T20:37:10.887733Z","caller":"traceutil/trace.go:171","msg":"trace[1198457340] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-741fbcae-5b2b-4e8a-b653-d383946aa740; range_end:; response_count:1; response_revision:5024; }","duration":"103.934562ms","start":"2026-08-19T20:37:10.783782Z","end":"2026-08-19T20:37:10.887717Z","steps":["trace[1198457340] 'agreement among raft nodes before linearized reading'  (duration: 103.716167ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:37:13.123387Z","caller":"traceutil/trace.go:171","msg":"trace[1465885026] linearizableReadLoop","detail":"{readStateIndex:5259; appliedIndex:5258; }","duration":"164.931328ms","start":"2026-08-19T20:37:12.958406Z","end":"2026-08-19T20:37:13.123337Z","steps":["trace[1465885026] 'read index received'  (duration: 148.507871ms)","trace[1465885026] 'applied index is now lower than readState.Index'  (duration: 16.421287ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:37:13.123408Z","caller":"traceutil/trace.go:171","msg":"trace[1226531179] transaction","detail":"{read_only:false; response_revision:5063; number_of_response:1; }","duration":"229.831357ms","start":"2026-08-19T20:37:12.893543Z","end":"2026-08-19T20:37:13.123374Z","steps":["trace[1226531179] 'process raft request'  (duration: 213.500392ms)","trace[1226531179] 'compare'  (duration: 15.971286ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:37:13.123752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.319637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:37:13.123988Z","caller":"traceutil/trace.go:171","msg":"trace[1362413294] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5063; }","duration":"165.4594ms","start":"2026-08-19T20:37:12.958347Z","end":"2026-08-19T20:37:13.123807Z","steps":["trace[1362413294] 'agreement among raft nodes before linearized reading'  (duration: 165.121412ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:37:25.731252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.640824ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16408196858275713881 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:5252 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T20:37:25.731436Z","caller":"traceutil/trace.go:171","msg":"trace[115258475] linearizableReadLoop","detail":"{readStateIndex:5505; appliedIndex:5504; }","duration":"529.430859ms","start":"2026-08-19T20:37:25.201981Z","end":"2026-08-19T20:37:25.731412Z","steps":["trace[115258475] 'read index received'  (duration: 9.421456ms)","trace[115258475] 'applied index is now lower than readState.Index'  (duration: 520.007263ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:37:25.731531Z","caller":"traceutil/trace.go:171","msg":"trace[1370837472] transaction","detail":"{read_only:false; response_revision:5301; number_of_response:1; }","duration":"556.1848ms","start":"2026-08-19T20:37:25.175328Z","end":"2026-08-19T20:37:25.731513Z","steps":["trace[1370837472] 'process raft request'  (duration: 36.133755ms)","trace[1370837472] 'compare'  (duration: 519.340437ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:37:25.731626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:37:25.175287Z","time spent":"556.275242ms","remote":"127.0.0.1:43946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:5252 > 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-08-19T20:37:25.731773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.776887ms","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-08-19T20:37:25.731834Z","caller":"traceutil/trace.go:171","msg":"trace[348992360] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5301; }","duration":"529.864629ms","start":"2026-08-19T20:37:25.201951Z","end":"2026-08-19T20:37:25.731816Z","steps":["trace[348992360] 'agreement among raft nodes before linearized reading'  (duration: 529.568932ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:37:25.731886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:37:25.201943Z","time spent":"529.93245ms","remote":"127.0.0.1:43946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-08-19T20:37:25.732292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.627849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-08-19T20:37:25.732371Z","caller":"traceutil/trace.go:171","msg":"trace[395421464] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5302; }","duration":"513.745653ms","start":"2026-08-19T20:37:25.218611Z","end":"2026-08-19T20:37:25.732357Z","steps":["trace[395421464] 'agreement among raft nodes before linearized reading'  (duration: 513.526528ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:37:25.732335Z","caller":"traceutil/trace.go:171","msg":"trace[1449841025] transaction","detail":"{read_only:false; response_revision:5302; number_of_response:1; }","duration":"265.940719ms","start":"2026-08-19T20:37:25.466344Z","end":"2026-08-19T20:37:25.732284Z","steps":["trace[1449841025] 'process raft request'  (duration: 265.655072ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:37:25.732377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.514389ms","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-08-19T20:37:25.732407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:37:25.218563Z","time spent":"513.837255ms","remote":"127.0.0.1:43946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-08-19T20:37:25.732427Z","caller":"traceutil/trace.go:171","msg":"trace[462008950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5302; }","duration":"308.58357ms","start":"2026-08-19T20:37:25.423831Z","end":"2026-08-19T20:37:25.732414Z","steps":["trace[462008950] 'agreement among raft nodes before linearized reading'  (duration: 308.466017ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:37:25.732463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:37:25.42382Z","time spent":"308.634311ms","remote":"127.0.0.1:43946","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-08-19T20:37:25.732512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.935868ms","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-08-19T20:37:25.73258Z","caller":"traceutil/trace.go:171","msg":"trace[2027215651] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5302; }","duration":"309.03541ms","start":"2026-08-19T20:37:25.423523Z","end":"2026-08-19T20:37:25.732559Z","steps":["trace[2027215651] 'agreement among raft nodes before linearized reading'  (duration: 308.855556ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:37:25.732622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:37:25.423502Z","time spent":"309.111333ms","remote":"127.0.0.1:43946","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-08-19T20:37:25.733072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.017145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"}
{"level":"info","ts":"2026-08-19T20:37:25.733131Z","caller":"traceutil/trace.go:171","msg":"trace[1053158755] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5302; }","duration":"105.104147ms","start":"2026-08-19T20:37:25.628013Z","end":"2026-08-19T20:37:25.733117Z","steps":["trace[1053158755] 'agreement among raft nodes before linearized reading'  (duration: 104.198495ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:37:33.171168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.126007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-pushgateway-7b8659c68b-s9vxf\" ","response":"range_response_count:1 size:4039"}
{"level":"info","ts":"2026-08-19T20:37:33.171249Z","caller":"traceutil/trace.go:171","msg":"trace[1671740513] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-pushgateway-7b8659c68b-s9vxf; range_end:; response_count:1; response_revision:5481; }","duration":"115.25337ms","start":"2026-08-19T20:37:33.055978Z","end":"2026-08-19T20:37:33.171232Z","steps":["trace[1671740513] 'range keys from in-memory index tree'  (duration: 114.979113ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:37:33.400526Z","caller":"traceutil/trace.go:171","msg":"trace[1429677128] transaction","detail":"{read_only:false; response_revision:5484; number_of_response:1; }","duration":"134.828179ms","start":"2026-08-19T20:37:33.265672Z","end":"2026-08-19T20:37:33.4005Z","steps":["trace[1429677128] 'process raft request'  (duration: 134.608554ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:37:33.40076Z","caller":"traceutil/trace.go:171","msg":"trace[2144300227] transaction","detail":"{read_only:false; response_revision:5485; number_of_response:1; }","duration":"133.834495ms","start":"2026-08-19T20:37:33.266897Z","end":"2026-08-19T20:37:33.400732Z","steps":["trace[2144300227] 'process raft request'  (duration: 133.548778ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:37:33.401019Z","caller":"traceutil/trace.go:171","msg":"trace[609057366] transaction","detail":"{read_only:false; response_revision:5486; number_of_response:1; }","duration":"133.984738ms","start":"2026-08-19T20:37:33.267008Z","end":"2026-08-19T20:37:33.400993Z","steps":["trace[609057366] 'process raft request'  (duration: 133.684101ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:37:33.401117Z","caller":"traceutil/trace.go:171","msg":"trace[1281103858] transaction","detail":"{read_only:false; response_revision:5487; number_of_response:1; }","duration":"133.913806ms","start":"2026-08-19T20:37:33.267193Z","end":"2026-08-19T20:37:33.401107Z","steps":["trace[1281103858] 'process raft request'  (duration: 133.664291ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:37:33.401199Z","caller":"traceutil/trace.go:171","msg":"trace[1535400739] transaction","detail":"{read_only:false; response_revision:5488; number_of_response:1; }","duration":"130.288699ms","start":"2026-08-19T20:37:33.270901Z","end":"2026-08-19T20:37:33.40119Z","steps":["trace[1535400739] 'process raft request'  (duration: 130.100815ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:37:33.557387Z","caller":"traceutil/trace.go:171","msg":"trace[1732771232] transaction","detail":"{read_only:false; response_revision:5489; number_of_response:1; }","duration":"152.142133ms","start":"2026-08-19T20:37:33.405202Z","end":"2026-08-19T20:37:33.557344Z","steps":["trace[1732771232] 'process raft request'  (duration: 61.413291ms)","trace[1732771232] 'compare'  (duration: 90.324823ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:37:43.360215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.765145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"}
{"level":"info","ts":"2026-08-19T20:37:43.360296Z","caller":"traceutil/trace.go:171","msg":"trace[486387992] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5612; }","duration":"103.904449ms","start":"2026-08-19T20:37:43.256373Z","end":"2026-08-19T20:37:43.360277Z","steps":["trace[486387992] 'range keys from in-memory index tree'  (duration: 103.451007ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:38:41.429759Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3005}
{"level":"info","ts":"2026-08-19T20:38:41.514129Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3005,"took":"82.65324ms","hash":95715883,"current-db-size-bytes":58052608,"current-db-size":"58 MB","current-db-size-in-use-bytes":31932416,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-19T20:38:41.514212Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":95715883,"revision":3005,"compact-revision":-1}
{"level":"info","ts":"2026-08-19T20:43:31.975393Z","caller":"traceutil/trace.go:171","msg":"trace[310313553] linearizableReadLoop","detail":"{readStateIndex:8539; appliedIndex:8538; }","duration":"218.941089ms","start":"2026-08-19T20:43:31.756429Z","end":"2026-08-19T20:43:31.97537Z","steps":["trace[310313553] 'read index received'  (duration: 218.877907ms)","trace[310313553] 'applied index is now lower than readState.Index'  (duration: 61.842µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:43:31.975484Z","caller":"traceutil/trace.go:171","msg":"trace[1265008574] transaction","detail":"{read_only:false; response_revision:8244; number_of_response:1; }","duration":"248.562777ms","start":"2026-08-19T20:43:31.726892Z","end":"2026-08-19T20:43:31.975455Z","steps":["trace[1265008574] 'process raft request'  (duration: 248.324601ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:43:31.975614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.166574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-08-19T20:43:31.975651Z","caller":"traceutil/trace.go:171","msg":"trace[31294052] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8244; }","duration":"219.289066ms","start":"2026-08-19T20:43:31.756353Z","end":"2026-08-19T20:43:31.975642Z","steps":["trace[31294052] 'agreement among raft nodes before linearized reading'  (duration: 219.139213ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:43:32.179743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.63681ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16408196858275721673 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8237 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T20:43:32.17986Z","caller":"traceutil/trace.go:171","msg":"trace[2042795422] linearizableReadLoop","detail":"{readStateIndex:8540; appliedIndex:8539; }","duration":"204.374145ms","start":"2026-08-19T20:43:31.975468Z","end":"2026-08-19T20:43:32.179842Z","steps":["trace[2042795422] 'read index received'  (duration: 96.517019ms)","trace[2042795422] 'applied index is now lower than readState.Index'  (duration: 107.855756ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:43:32.179972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.691145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-19T20:43:32.180016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.444252ms","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-08-19T20:43:32.18004Z","caller":"traceutil/trace.go:171","msg":"trace[302616618] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8245; }","duration":"422.483294ms","start":"2026-08-19T20:43:31.757549Z","end":"2026-08-19T20:43:32.180032Z","steps":["trace[302616618] 'agreement among raft nodes before linearized reading'  (duration: 422.359081ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:43:32.180038Z","caller":"traceutil/trace.go:171","msg":"trace[100152312] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8245; }","duration":"221.818107ms","start":"2026-08-19T20:43:31.958209Z","end":"2026-08-19T20:43:32.180027Z","steps":["trace[100152312] 'agreement among raft nodes before linearized reading'  (duration: 221.680284ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:43:32.180031Z","caller":"traceutil/trace.go:171","msg":"trace[1744630267] transaction","detail":"{read_only:false; response_revision:8245; number_of_response:1; }","duration":"418.850096ms","start":"2026-08-19T20:43:31.761154Z","end":"2026-08-19T20:43:32.180004Z","steps":["trace[1744630267] 'process raft request'  (duration: 310.858847ms)","trace[1744630267] 'compare'  (duration: 107.471937ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:43:32.18007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:43:31.757535Z","time spent":"422.529474ms","remote":"127.0.0.1:43946","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-08-19T20:43:32.180143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:43:31.761134Z","time spent":"418.936228ms","remote":"127.0.0.1:43946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8237 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-08-19T20:43:32.180395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.208461ms","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-08-19T20:43:32.180425Z","caller":"traceutil/trace.go:171","msg":"trace[1936293328] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8245; }","duration":"423.284523ms","start":"2026-08-19T20:43:31.75713Z","end":"2026-08-19T20:43:32.180414Z","steps":["trace[1936293328] 'agreement among raft nodes before linearized reading'  (duration: 423.17964ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:43:32.180443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:43:31.757104Z","time spent":"423.334093ms","remote":"127.0.0.1:43946","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-08-19T20:43:32.182209Z","caller":"traceutil/trace.go:171","msg":"trace[1830067579] transaction","detail":"{read_only:false; response_revision:8246; number_of_response:1; }","duration":"201.913596ms","start":"2026-08-19T20:43:31.980284Z","end":"2026-08-19T20:43:32.182198Z","steps":["trace[1830067579] 'process raft request'  (duration: 201.718511ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:43:32.182571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.242351ms","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-08-19T20:43:32.182599Z","caller":"traceutil/trace.go:171","msg":"trace[1429157591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8246; }","duration":"185.306703ms","start":"2026-08-19T20:43:31.997284Z","end":"2026-08-19T20:43:32.18259Z","steps":["trace[1429157591] 'agreement among raft nodes before linearized reading'  (duration: 185.232601ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:43:32.182688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.077282ms","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-08-19T20:43:32.182705Z","caller":"traceutil/trace.go:171","msg":"trace[102098240] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8246; }","duration":"186.131223ms","start":"2026-08-19T20:43:31.996567Z","end":"2026-08-19T20:43:32.182698Z","steps":["trace[102098240] 'agreement among raft nodes before linearized reading'  (duration: 186.080852ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:43:41.448236Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6103}
{"level":"info","ts":"2026-08-19T20:43:41.584294Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6103,"took":"133.21366ms","hash":308086995,"current-db-size-bytes":58052608,"current-db-size":"58 MB","current-db-size-in-use-bytes":23572480,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-08-19T20:43:41.584365Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":308086995,"revision":6103,"compact-revision":3005}
{"level":"info","ts":"2026-08-19T20:43:44.155491Z","caller":"traceutil/trace.go:171","msg":"trace[1964685537] transaction","detail":"{read_only:false; response_revision:8308; number_of_response:1; }","duration":"110.961651ms","start":"2026-08-19T20:43:44.044493Z","end":"2026-08-19T20:43:44.155454Z","steps":["trace[1964685537] 'process raft request'  (duration: 110.752576ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:43:45.829977Z","caller":"traceutil/trace.go:171","msg":"trace[516723908] transaction","detail":"{read_only:false; response_revision:8318; number_of_response:1; }","duration":"119.785066ms","start":"2026-08-19T20:43:45.710145Z","end":"2026-08-19T20:43:45.82993Z","steps":["trace[516723908] 'process raft request'  (duration: 60.524948ms)","trace[516723908] 'compare'  (duration: 58.93148ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:44:13.703295Z","caller":"traceutil/trace.go:171","msg":"trace[2144001954] transaction","detail":"{read_only:false; response_revision:8520; number_of_response:1; }","duration":"271.403167ms","start":"2026-08-19T20:44:13.431856Z","end":"2026-08-19T20:44:13.703259Z","steps":["trace[2144001954] 'process raft request'  (duration: 271.172262ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:44:13.704723Z","caller":"traceutil/trace.go:171","msg":"trace[868448706] linearizableReadLoop","detail":"{readStateIndex:8828; appliedIndex:8826; }","duration":"105.045539ms","start":"2026-08-19T20:44:13.599647Z","end":"2026-08-19T20:44:13.704692Z","steps":["trace[868448706] 'read index received'  (duration: 103.42866ms)","trace[868448706] 'applied index is now lower than readState.Index'  (duration: 1.615509ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:44:13.704891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.223844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:44:13.704939Z","caller":"traceutil/trace.go:171","msg":"trace[1288441041] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:8521; }","duration":"105.295736ms","start":"2026-08-19T20:44:13.599629Z","end":"2026-08-19T20:44:13.704924Z","steps":["trace[1288441041] 'agreement among raft nodes before linearized reading'  (duration: 105.185843ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:44:13.704956Z","caller":"traceutil/trace.go:171","msg":"trace[1168260755] transaction","detail":"{read_only:false; response_revision:8521; number_of_response:1; }","duration":"263.767711ms","start":"2026-08-19T20:44:13.441155Z","end":"2026-08-19T20:44:13.704922Z","steps":["trace[1168260755] 'process raft request'  (duration: 263.379302ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:44:26.238251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.516464ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16408196858275722886 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/openstack/rook-ceph-detect-version-l92rv\" mod_revision:8627 > success:<request_put:<key:\"/registry/pods/openstack/rook-ceph-detect-version-l92rv\" value_size:4574 >> failure:<request_range:<key:\"/registry/pods/openstack/rook-ceph-detect-version-l92rv\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T20:44:26.238427Z","caller":"traceutil/trace.go:171","msg":"trace[615331489] linearizableReadLoop","detail":"{readStateIndex:8942; appliedIndex:8941; }","duration":"281.001039ms","start":"2026-08-19T20:44:25.957392Z","end":"2026-08-19T20:44:26.238393Z","steps":["trace[615331489] 'read index received'  (duration: 111.29172ms)","trace[615331489] 'applied index is now lower than readState.Index'  (duration: 169.707019ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:44:26.238814Z","caller":"traceutil/trace.go:171","msg":"trace[1100304248] transaction","detail":"{read_only:false; response_revision:8629; number_of_response:1; }","duration":"306.781066ms","start":"2026-08-19T20:44:25.931908Z","end":"2026-08-19T20:44:26.238689Z","steps":["trace[1100304248] 'process raft request'  (duration: 136.686378ms)","trace[1100304248] 'compare'  (duration: 169.34592ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:44:26.238717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.322747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-19T20:44:26.239067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:44:25.931899Z","time spent":"307.035202ms","remote":"127.0.0.1:43872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4637,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/rook-ceph-detect-version-l92rv\" mod_revision:8627 > success:<request_put:<key:\"/registry/pods/openstack/rook-ceph-detect-version-l92rv\" value_size:4574 >> failure:<request_range:<key:\"/registry/pods/openstack/rook-ceph-detect-version-l92rv\" > >"}
{"level":"info","ts":"2026-08-19T20:44:26.239075Z","caller":"traceutil/trace.go:171","msg":"trace[59037440] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8629; }","duration":"281.725627ms","start":"2026-08-19T20:44:25.957331Z","end":"2026-08-19T20:44:26.239057Z","steps":["trace[59037440] 'agreement among raft nodes before linearized reading'  (duration: 281.150173ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:44:39.648166Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002366.wal"}
{"level":"info","ts":"2026-08-19T20:44:39.65106Z","caller":"traceutil/trace.go:171","msg":"trace[876253909] transaction","detail":"{read_only:false; response_revision:8744; number_of_response:1; }","duration":"114.343165ms","start":"2026-08-19T20:44:39.536682Z","end":"2026-08-19T20:44:39.651025Z","steps":["trace[876253909] 'process raft request'  (duration: 111.712871ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:44:39.651057Z","caller":"traceutil/trace.go:171","msg":"trace[1041872207] transaction","detail":"{read_only:false; response_revision:8745; number_of_response:1; }","duration":"113.901105ms","start":"2026-08-19T20:44:39.537124Z","end":"2026-08-19T20:44:39.651025Z","steps":["trace[1041872207] 'process raft request'  (duration: 113.848034ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:45:38.241999Z","caller":"traceutil/trace.go:171","msg":"trace[37238836] transaction","detail":"{read_only:false; response_revision:9291; number_of_response:1; }","duration":"106.012283ms","start":"2026-08-19T20:45:38.13596Z","end":"2026-08-19T20:45:38.241972Z","steps":["trace[37238836] 'process raft request'  (duration: 105.861069ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:45:38.253741Z","caller":"traceutil/trace.go:171","msg":"trace[452388726] transaction","detail":"{read_only:false; response_revision:9292; number_of_response:1; }","duration":"109.960758ms","start":"2026-08-19T20:45:38.143761Z","end":"2026-08-19T20:45:38.253722Z","steps":["trace[452388726] 'process raft request'  (duration: 109.859015ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:46:19.240204Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"173f1df9994fe3b5","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-19T20:46:19.245679Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-19T20:46:19.245775Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-19T20:48:41.455401Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8296}
{"level":"info","ts":"2026-08-19T20:48:41.536581Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8296,"took":"78.199524ms","hash":1661908434,"current-db-size-bytes":58052608,"current-db-size":"58 MB","current-db-size-in-use-bytes":26529792,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-08-19T20:48:41.536657Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1661908434,"revision":8296,"compact-revision":6103}
{"level":"info","ts":"2026-08-19T20:49:22.275706Z","caller":"traceutil/trace.go:171","msg":"trace[1839567314] transaction","detail":"{read_only:false; response_revision:11236; number_of_response:1; }","duration":"178.104509ms","start":"2026-08-19T20:49:22.097553Z","end":"2026-08-19T20:49:22.275658Z","steps":["trace[1839567314] 'process raft request'  (duration: 177.679849ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:53:41.463643Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10818}
{"level":"info","ts":"2026-08-19T20:53:41.550207Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10818,"took":"83.103424ms","hash":2302586234,"current-db-size-bytes":58052608,"current-db-size":"58 MB","current-db-size-in-use-bytes":27844608,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-19T20:53:41.550283Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2302586234,"revision":10818,"compact-revision":8296}
{"level":"warn","ts":"2026-08-19T20:55:13.402117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.884137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:55:13.402256Z","caller":"traceutil/trace.go:171","msg":"trace[1324744363] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:13635; }","duration":"131.099732ms","start":"2026-08-19T20:55:13.271129Z","end":"2026-08-19T20:55:13.402229Z","steps":["trace[1324744363] 'range keys from in-memory index tree'  (duration: 130.770804ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:55:16.55393Z","caller":"traceutil/trace.go:171","msg":"trace[425418556] transaction","detail":"{read_only:false; response_revision:13652; number_of_response:1; }","duration":"157.279949ms","start":"2026-08-19T20:55:16.396615Z","end":"2026-08-19T20:55:16.553895Z","steps":["trace[425418556] 'process raft request'  (duration: 156.91873ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:55:36.605308Z","caller":"traceutil/trace.go:171","msg":"trace[1792363467] transaction","detail":"{read_only:false; response_revision:13762; number_of_response:1; }","duration":"207.382009ms","start":"2026-08-19T20:55:36.397895Z","end":"2026-08-19T20:55:36.605277Z","steps":["trace[1792363467] 'process raft request'  (duration: 207.203435ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:55:52.367954Z","caller":"traceutil/trace.go:171","msg":"trace[87592384] linearizableReadLoop","detail":"{readStateIndex:14339; appliedIndex:14338; }","duration":"153.983649ms","start":"2026-08-19T20:55:52.213943Z","end":"2026-08-19T20:55:52.367926Z","steps":["trace[87592384] 'read index received'  (duration: 153.714693ms)","trace[87592384] 'applied index is now lower than readState.Index'  (duration: 267.886µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:55:52.368188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.226025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-19T20:55:52.368239Z","caller":"traceutil/trace.go:171","msg":"trace[590280681] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:13855; }","duration":"154.349337ms","start":"2026-08-19T20:55:52.213873Z","end":"2026-08-19T20:55:52.368222Z","steps":["trace[590280681] 'agreement among raft nodes before linearized reading'  (duration: 154.174553ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:55:52.368458Z","caller":"traceutil/trace.go:171","msg":"trace[1980168380] transaction","detail":"{read_only:false; response_revision:13855; number_of_response:1; }","duration":"282.839777ms","start":"2026-08-19T20:55:52.085574Z","end":"2026-08-19T20:55:52.368414Z","steps":["trace[1980168380] 'process raft request'  (duration: 282.183521ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:56:01.806872Z","caller":"traceutil/trace.go:171","msg":"trace[1338204740] linearizableReadLoop","detail":"{readStateIndex:14503; appliedIndex:14502; }","duration":"221.504083ms","start":"2026-08-19T20:56:01.585345Z","end":"2026-08-19T20:56:01.806849Z","steps":["trace[1338204740] 'read index received'  (duration: 221.299418ms)","trace[1338204740] 'applied index is now lower than readState.Index'  (duration: 203.795µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:56:01.806937Z","caller":"traceutil/trace.go:171","msg":"trace[1212510611] transaction","detail":"{read_only:false; response_revision:14016; number_of_response:1; }","duration":"285.85898ms","start":"2026-08-19T20:56:01.521026Z","end":"2026-08-19T20:56:01.806885Z","steps":["trace[1212510611] 'process raft request'  (duration: 285.683635ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:56:01.807218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.204132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-19T20:56:01.807253Z","caller":"traceutil/trace.go:171","msg":"trace[449062982] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:14016; }","duration":"172.296204ms","start":"2026-08-19T20:56:01.634944Z","end":"2026-08-19T20:56:01.80724Z","steps":["trace[449062982] 'agreement among raft nodes before linearized reading'  (duration: 172.217142ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:56:01.807137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.78392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-08-19T20:56:01.807411Z","caller":"traceutil/trace.go:171","msg":"trace[1309784698] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:14016; }","duration":"222.096157ms","start":"2026-08-19T20:56:01.585271Z","end":"2026-08-19T20:56:01.807367Z","steps":["trace[1309784698] 'agreement among raft nodes before linearized reading'  (duration: 221.709398ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:56:02.080704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.490002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:56:02.080828Z","caller":"traceutil/trace.go:171","msg":"trace[398331392] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14017; }","duration":"122.677787ms","start":"2026-08-19T20:56:01.958125Z","end":"2026-08-19T20:56:02.080803Z","steps":["trace[398331392] 'range keys from in-memory index tree'  (duration: 122.37388ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:57:17.27181Z","caller":"traceutil/trace.go:171","msg":"trace[1970952531] transaction","detail":"{read_only:false; response_revision:14972; number_of_response:1; }","duration":"361.125463ms","start":"2026-08-19T20:57:16.910656Z","end":"2026-08-19T20:57:17.271782Z","steps":["trace[1970952531] 'process raft request'  (duration: 360.881647ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:57:17.272031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:57:16.910617Z","time spent":"361.275537ms","remote":"127.0.0.1:43946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:14958 > 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-08-19T20:57:17.38241Z","caller":"traceutil/trace.go:171","msg":"trace[730409491] linearizableReadLoop","detail":"{readStateIndex:15489; appliedIndex:15487; }","duration":"464.904498ms","start":"2026-08-19T20:57:16.917474Z","end":"2026-08-19T20:57:17.382378Z","steps":["trace[730409491] 'read index received'  (duration: 354.103873ms)","trace[730409491] 'applied index is now lower than readState.Index'  (duration: 110.799675ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:57:17.382565Z","caller":"traceutil/trace.go:171","msg":"trace[390426546] transaction","detail":"{read_only:false; response_revision:14973; number_of_response:1; }","duration":"469.710295ms","start":"2026-08-19T20:57:16.912806Z","end":"2026-08-19T20:57:17.382516Z","steps":["trace[390426546] 'process raft request'  (duration: 424.314181ms)","trace[390426546] 'compare'  (duration: 44.942243ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:57:17.382665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.138113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:57:17.382709Z","caller":"traceutil/trace.go:171","msg":"trace[170353051] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14975; }","duration":"465.246906ms","start":"2026-08-19T20:57:16.917452Z","end":"2026-08-19T20:57:17.382699Z","steps":["trace[170353051] 'agreement among raft nodes before linearized reading'  (duration: 465.102982ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:57:17.382749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:57:16.917443Z","time spent":"465.298978ms","remote":"127.0.0.1:43914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "}
{"level":"warn","ts":"2026-08-19T20:57:17.38275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:57:16.912783Z","time spent":"469.865468ms","remote":"127.0.0.1:43946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:14959 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-08-19T20:57:17.382804Z","caller":"traceutil/trace.go:171","msg":"trace[1199560293] transaction","detail":"{read_only:false; response_revision:14974; number_of_response:1; }","duration":"255.070144ms","start":"2026-08-19T20:57:17.127718Z","end":"2026-08-19T20:57:17.382788Z","steps":["trace[1199560293] 'process raft request'  (duration: 254.521741ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:57:17.382705Z","caller":"traceutil/trace.go:171","msg":"trace[893280049] transaction","detail":"{read_only:false; response_revision:14975; number_of_response:1; }","duration":"254.025659ms","start":"2026-08-19T20:57:17.128563Z","end":"2026-08-19T20:57:17.382589Z","steps":["trace[893280049] 'process raft request'  (duration: 253.717962ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:57:17.382901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.916998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"}
{"level":"info","ts":"2026-08-19T20:57:17.38298Z","caller":"traceutil/trace.go:171","msg":"trace[170363095] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14975; }","duration":"465.037241ms","start":"2026-08-19T20:57:16.91792Z","end":"2026-08-19T20:57:17.382958Z","steps":["trace[170363095] 'agreement among raft nodes before linearized reading'  (duration: 464.735694ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:57:17.383121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.586287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"}
{"level":"info","ts":"2026-08-19T20:57:17.383156Z","caller":"traceutil/trace.go:171","msg":"trace[447312484] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14975; }","duration":"440.638617ms","start":"2026-08-19T20:57:16.94251Z","end":"2026-08-19T20:57:17.383149Z","steps":["trace[447312484] 'agreement among raft nodes before linearized reading'  (duration: 440.509754ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:57:17.383183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:57:16.942501Z","time spent":"440.675498ms","remote":"127.0.0.1:43864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":690,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "}
{"level":"warn","ts":"2026-08-19T20:57:17.383204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.552568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-08-19T20:57:17.383228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.857083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"warn","ts":"2026-08-19T20:57:17.383283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.299419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"}
{"level":"warn","ts":"2026-08-19T20:57:17.383342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.021347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:57:17.383351Z","caller":"traceutil/trace.go:171","msg":"trace[461136536] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14975; }","duration":"440.987956ms","start":"2026-08-19T20:57:16.94234Z","end":"2026-08-19T20:57:17.383328Z","steps":["trace[461136536] 'agreement among raft nodes before linearized reading'  (duration: 440.719629ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:57:17.38337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.320885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"warn","ts":"2026-08-19T20:57:17.383392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.88715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"warn","ts":"2026-08-19T20:57:17.383415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:57:16.942333Z","time spent":"441.067927ms","remote":"127.0.0.1:43914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5546,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"info","ts":"2026-08-19T20:57:17.383433Z","caller":"traceutil/trace.go:171","msg":"trace[2037907196] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14975; }","duration":"441.069747ms","start":"2026-08-19T20:57:16.942292Z","end":"2026-08-19T20:57:17.383362Z","steps":["trace[2037907196] 'agreement among raft nodes before linearized reading'  (duration: 441.001276ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:57:17.383396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.587482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-19T20:57:17.383289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.747172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"warn","ts":"2026-08-19T20:57:17.383478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.024573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"}
{"level":"info","ts":"2026-08-19T20:57:17.383513Z","caller":"traceutil/trace.go:171","msg":"trace[533504249] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14975; }","duration":"440.111725ms","start":"2026-08-19T20:57:16.943391Z","end":"2026-08-19T20:57:17.383503Z","steps":["trace[533504249] 'agreement among raft nodes before linearized reading'  (duration: 440.009232ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:57:17.383533Z","caller":"traceutil/trace.go:171","msg":"trace[207963294] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14975; }","duration":"425.810967ms","start":"2026-08-19T20:57:16.957689Z","end":"2026-08-19T20:57:17.3835Z","steps":["trace[207963294] 'agreement among raft nodes before linearized reading'  (duration: 425.507869ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:57:17.383525Z","caller":"traceutil/trace.go:171","msg":"trace[754346564] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14975; }","duration":"217.032759ms","start":"2026-08-19T20:57:17.16647Z","end":"2026-08-19T20:57:17.383503Z","steps":["trace[754346564] 'agreement among raft nodes before linearized reading'  (duration: 216.595068ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:57:17.383546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.209948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"}
{"level":"info","ts":"2026-08-19T20:57:17.383587Z","caller":"traceutil/trace.go:171","msg":"trace[785389777] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14975; }","duration":"239.2779ms","start":"2026-08-19T20:57:17.144301Z","end":"2026-08-19T20:57:17.383579Z","steps":["trace[785389777] 'agreement among raft nodes before linearized reading'  (duration: 239.189017ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:57:17.383618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:57:16.957663Z","time spent":"425.92159ms","remote":"127.0.0.1:43708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-08-19T20:57:17.383463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:57:16.942281Z","time spent":"441.17569ms","remote":"127.0.0.1:43914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "}
{"level":"info","ts":"2026-08-19T20:57:17.383411Z","caller":"traceutil/trace.go:171","msg":"trace[192607625] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:14975; }","duration":"446.417947ms","start":"2026-08-19T20:57:16.936984Z","end":"2026-08-19T20:57:17.383402Z","steps":["trace[192607625] 'agreement among raft nodes before linearized reading'  (duration: 446.298535ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:57:17.383824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.08977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-dsnbf\" ","response":"range_response_count:1 size:9792"}
{"level":"warn","ts":"2026-08-19T20:57:17.383194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.946785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-sthh2\" ","response":"range_response_count:1 size:20649"}
{"level":"info","ts":"2026-08-19T20:57:17.383875Z","caller":"traceutil/trace.go:171","msg":"trace[6660678] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-dsnbf; range_end:; response_count:1; response_revision:14975; }","duration":"210.160392ms","start":"2026-08-19T20:57:17.173702Z","end":"2026-08-19T20:57:17.383863Z","steps":["trace[6660678] 'agreement among raft nodes before linearized reading'  (duration: 209.941746ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:57:17.383892Z","caller":"traceutil/trace.go:171","msg":"trace[1298237145] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-sthh2; range_end:; response_count:1; response_revision:14975; }","duration":"441.675773ms","start":"2026-08-19T20:57:16.9422Z","end":"2026-08-19T20:57:17.383875Z","steps":["trace[1298237145] 'agreement among raft nodes before linearized reading'  (duration: 440.793691ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:57:17.383239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.226603ms","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-08-19T20:57:17.383969Z","caller":"traceutil/trace.go:171","msg":"trace[1227141808] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14975; }","duration":"460.966713ms","start":"2026-08-19T20:57:16.922983Z","end":"2026-08-19T20:57:17.38395Z","steps":["trace[1227141808] 'agreement among raft nodes before linearized reading'  (duration: 460.161502ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:57:17.383828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:57:16.936953Z","time spent":"446.863658ms","remote":"127.0.0.1:43946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":553,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "}
{"level":"warn","ts":"2026-08-19T20:57:17.384037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:57:16.922951Z","time spent":"461.067285ms","remote":"127.0.0.1:43946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-08-19T20:57:17.383455Z","caller":"traceutil/trace.go:171","msg":"trace[1071028135] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14975; }","duration":"460.988752ms","start":"2026-08-19T20:57:16.922451Z","end":"2026-08-19T20:57:17.383439Z","steps":["trace[1071028135] 'agreement among raft nodes before linearized reading'  (duration: 460.817188ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:57:17.383112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:57:16.917913Z","time spent":"465.109172ms","remote":"127.0.0.1:43864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":690,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "}
{"level":"warn","ts":"2026-08-19T20:57:17.383554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:57:16.943362Z","time spent":"440.184777ms","remote":"127.0.0.1:43914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5546,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"info","ts":"2026-08-19T20:57:17.383256Z","caller":"traceutil/trace.go:171","msg":"trace[1510677825] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14975; }","duration":"457.656722ms","start":"2026-08-19T20:57:16.925585Z","end":"2026-08-19T20:57:17.383242Z","steps":["trace[1510677825] 'agreement among raft nodes before linearized reading'  (duration: 457.505108ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:57:17.384407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:57:16.925577Z","time spent":"458.81535ms","remote":"127.0.0.1:43946","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-08-19T20:57:17.383923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:57:16.942187Z","time spent":"441.725545ms","remote":"127.0.0.1:43872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20672,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-sthh2\" "}
{"level":"info","ts":"2026-08-19T20:57:17.383376Z","caller":"traceutil/trace.go:171","msg":"trace[1214252580] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14975; }","duration":"440.396921ms","start":"2026-08-19T20:57:16.942957Z","end":"2026-08-19T20:57:17.383354Z","steps":["trace[1214252580] 'agreement among raft nodes before linearized reading'  (duration: 439.972031ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:57:17.384618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:57:16.942925Z","time spent":"441.679803ms","remote":"127.0.0.1:43864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":690,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "}
{"level":"warn","ts":"2026-08-19T20:57:17.384231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:57:16.922439Z","time spent":"461.749861ms","remote":"127.0.0.1:43914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5546,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"warn","ts":"2026-08-19T20:57:17.383458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.059614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:57:17.38493Z","caller":"traceutil/trace.go:171","msg":"trace[1684123725] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14975; }","duration":"441.54227ms","start":"2026-08-19T20:57:16.943376Z","end":"2026-08-19T20:57:17.384919Z","steps":["trace[1684123725] 'agreement among raft nodes before linearized reading'  (duration: 440.059283ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:57:17.384968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:57:16.943367Z","time spent":"441.591711ms","remote":"127.0.0.1:43914","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "}
{"level":"info","ts":"2026-08-19T20:58:41.469522Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12982}
{"level":"info","ts":"2026-08-19T20:58:41.548577Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12982,"took":"76.516672ms","hash":2641345648,"current-db-size-bytes":58052608,"current-db-size":"58 MB","current-db-size-in-use-bytes":30543872,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-19T20:58:41.548662Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2641345648,"revision":12982,"compact-revision":10818}
{"level":"info","ts":"2026-08-19T21:03:19.354218Z","caller":"traceutil/trace.go:171","msg":"trace[1418068026] transaction","detail":"{read_only:false; response_revision:17648; number_of_response:1; }","duration":"138.357934ms","start":"2026-08-19T21:03:19.215831Z","end":"2026-08-19T21:03:19.354189Z","steps":["trace[1418068026] 'process raft request'  (duration: 137.302808ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:03:21.585191Z","caller":"traceutil/trace.go:171","msg":"trace[1537829816] transaction","detail":"{read_only:false; response_revision:17668; number_of_response:1; }","duration":"125.043248ms","start":"2026-08-19T21:03:21.460119Z","end":"2026-08-19T21:03:21.585162Z","steps":["trace[1537829816] 'process raft request'  (duration: 100.755507ms)","trace[1537829816] 'compare'  (duration: 24.110247ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:03:21.585586Z","caller":"traceutil/trace.go:171","msg":"trace[902975543] transaction","detail":"{read_only:false; response_revision:17669; number_of_response:1; }","duration":"125.214154ms","start":"2026-08-19T21:03:21.460315Z","end":"2026-08-19T21:03:21.585529Z","steps":["trace[902975543] 'process raft request'  (duration: 124.799223ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:03:21.585697Z","caller":"traceutil/trace.go:171","msg":"trace[1988776470] linearizableReadLoop","detail":"{readStateIndex:18276; appliedIndex:18273; }","duration":"125.06431ms","start":"2026-08-19T21:03:21.460598Z","end":"2026-08-19T21:03:21.585662Z","steps":["trace[1988776470] 'read index received'  (duration: 17.499247ms)","trace[1988776470] 'applied index is now lower than readState.Index'  (duration: 107.559473ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:03:21.585896Z","caller":"traceutil/trace.go:171","msg":"trace[2133833010] transaction","detail":"{read_only:false; response_revision:17671; number_of_response:1; }","duration":"124.794374ms","start":"2026-08-19T21:03:21.461067Z","end":"2026-08-19T21:03:21.585861Z","steps":["trace[2133833010] 'process raft request'  (duration: 124.462146ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:03:21.585999Z","caller":"traceutil/trace.go:171","msg":"trace[1123202612] transaction","detail":"{read_only:false; response_revision:17670; number_of_response:1; }","duration":"125.514511ms","start":"2026-08-19T21:03:21.460455Z","end":"2026-08-19T21:03:21.58597Z","steps":["trace[1123202612] 'process raft request'  (duration: 124.934617ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:03:21.586005Z","caller":"traceutil/trace.go:171","msg":"trace[560675640] transaction","detail":"{read_only:false; response_revision:17672; number_of_response:1; }","duration":"124.569209ms","start":"2026-08-19T21:03:21.461392Z","end":"2026-08-19T21:03:21.585962Z","steps":["trace[560675640] 'process raft request'  (duration: 124.20025ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:21.590015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.391735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:96 size:939914"}
{"level":"info","ts":"2026-08-19T21:03:21.590096Z","caller":"traceutil/trace.go:171","msg":"trace[852180276] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:96; response_revision:17672; }","duration":"129.527569ms","start":"2026-08-19T21:03:21.46055Z","end":"2026-08-19T21:03:21.590078Z","steps":["trace[852180276] 'agreement among raft nodes before linearized reading'  (duration: 125.361577ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:25.036449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.181902ms","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-08-19T21:03:25.036572Z","caller":"traceutil/trace.go:171","msg":"trace[1598175899] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:17703; }","duration":"225.358745ms","start":"2026-08-19T21:03:24.811188Z","end":"2026-08-19T21:03:25.036547Z","steps":["trace[1598175899] 'range keys from in-memory index tree'  (duration: 225.047888ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:03:25.036636Z","caller":"traceutil/trace.go:171","msg":"trace[1458122251] transaction","detail":"{read_only:false; response_revision:17704; number_of_response:1; }","duration":"125.817608ms","start":"2026-08-19T21:03:24.910789Z","end":"2026-08-19T21:03:25.036606Z","steps":["trace[1458122251] 'process raft request'  (duration: 105.048632ms)","trace[1458122251] 'compare'  (duration: 20.451928ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:03:41.476512Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15489}
{"level":"info","ts":"2026-08-19T21:03:41.578232Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15489,"took":"98.225365ms","hash":3092668967,"current-db-size-bytes":58052608,"current-db-size":"58 MB","current-db-size-in-use-bytes":32043008,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-19T21:03:41.578304Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3092668967,"revision":15489,"compact-revision":12982}
{"level":"info","ts":"2026-08-19T21:06:36.096363Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"173f1df9994fe3b5","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-19T21:06:36.101753Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-19T21:06:36.101832Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"warn","ts":"2026-08-19T21:08:29.529826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.363142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-08-19T21:08:29.529965Z","caller":"traceutil/trace.go:171","msg":"trace[646053279] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20134; }","duration":"167.532797ms","start":"2026-08-19T21:08:29.362403Z","end":"2026-08-19T21:08:29.529936Z","steps":["trace[646053279] 'range keys from in-memory index tree'  (duration: 167.083915ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:08:29.529908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.331022ms","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-08-19T21:08:29.530166Z","caller":"traceutil/trace.go:171","msg":"trace[745002100] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20134; }","duration":"167.66174ms","start":"2026-08-19T21:08:29.362478Z","end":"2026-08-19T21:08:29.53014Z","steps":["trace[745002100] 'range keys from in-memory index tree'  (duration: 167.029504ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:08:29.530212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.754002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-08-19T21:08:29.530312Z","caller":"traceutil/trace.go:171","msg":"trace[422647002] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20134; }","duration":"167.890305ms","start":"2026-08-19T21:08:29.362399Z","end":"2026-08-19T21:08:29.530289Z","steps":["trace[422647002] 'range keys from in-memory index tree'  (duration: 167.579057ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:08:29.530399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.664025ms","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-08-19T21:08:29.530481Z","caller":"traceutil/trace.go:171","msg":"trace[385997835] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20134; }","duration":"194.778127ms","start":"2026-08-19T21:08:29.335684Z","end":"2026-08-19T21:08:29.530462Z","steps":["trace[385997835] 'range keys from in-memory index tree'  (duration: 194.401478ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:08:29.530506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.997995ms","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-08-19T21:08:29.530548Z","caller":"traceutil/trace.go:171","msg":"trace[1064339714] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20134; }","duration":"174.097558ms","start":"2026-08-19T21:08:29.356435Z","end":"2026-08-19T21:08:29.530532Z","steps":["trace[1064339714] 'range keys from in-memory index tree'  (duration: 173.843222ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:08:41.48402Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17875}
{"level":"info","ts":"2026-08-19T21:08:41.607395Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17875,"took":"118.17564ms","hash":3191625301,"current-db-size-bytes":58052608,"current-db-size":"58 MB","current-db-size-in-use-bytes":30162944,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-19T21:08:41.607608Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3191625301,"revision":17875,"compact-revision":15489}
{"level":"info","ts":"2026-08-19T21:08:55.484135Z","caller":"traceutil/trace.go:171","msg":"trace[860993516] transaction","detail":"{read_only:false; response_revision:20267; number_of_response:1; }","duration":"113.570946ms","start":"2026-08-19T21:08:55.370539Z","end":"2026-08-19T21:08:55.48411Z","steps":["trace[860993516] 'process raft request'  (duration: 113.437543ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:08:56.402625Z","caller":"traceutil/trace.go:171","msg":"trace[109876767] transaction","detail":"{read_only:false; response_revision:20268; number_of_response:1; }","duration":"674.509772ms","start":"2026-08-19T21:08:55.728084Z","end":"2026-08-19T21:08:56.402594Z","steps":["trace[109876767] 'process raft request'  (duration: 674.344768ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:08:56.402807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:08:55.728063Z","time spent":"674.650306ms","remote":"127.0.0.1:43946","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:20259 > 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-08-19T21:08:56.488852Z","caller":"traceutil/trace.go:171","msg":"trace[627651402] linearizableReadLoop","detail":"{readStateIndex:20964; appliedIndex:20959; }","duration":"530.068145ms","start":"2026-08-19T21:08:55.958761Z","end":"2026-08-19T21:08:56.488829Z","steps":["trace[627651402] 'read index received'  (duration: 443.625756ms)","trace[627651402] 'applied index is now lower than readState.Index'  (duration: 86.441049ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:08:56.488994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.224239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:08:56.489035Z","caller":"traceutil/trace.go:171","msg":"trace[154403594] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20272; }","duration":"530.312661ms","start":"2026-08-19T21:08:55.958711Z","end":"2026-08-19T21:08:56.489023Z","steps":["trace[154403594] 'agreement among raft nodes before linearized reading'  (duration: 530.215178ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:08:56.489073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:08:55.95869Z","time spent":"530.377103ms","remote":"127.0.0.1:43708","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-08-19T21:08:56.489065Z","caller":"traceutil/trace.go:171","msg":"trace[1711799658] transaction","detail":"{read_only:false; response_revision:20269; number_of_response:1; }","duration":"760.752706ms","start":"2026-08-19T21:08:55.728241Z","end":"2026-08-19T21:08:56.488994Z","steps":["trace[1711799658] 'process raft request'  (duration: 760.259514ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:08:56.489277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:08:55.728214Z","time spent":"760.936021ms","remote":"127.0.0.1:43946","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:20258 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-08-19T21:08:56.48933Z","caller":"traceutil/trace.go:171","msg":"trace[803855913] transaction","detail":"{read_only:false; response_revision:20271; number_of_response:1; }","duration":"760.367947ms","start":"2026-08-19T21:08:55.728952Z","end":"2026-08-19T21:08:56.48932Z","steps":["trace[803855913] 'process raft request'  (duration: 759.807513ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:08:56.489423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:08:55.728926Z","time spent":"760.430488ms","remote":"127.0.0.1:43946","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:20262 > 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-08-19T21:08:56.489525Z","caller":"traceutil/trace.go:171","msg":"trace[1322706758] transaction","detail":"{read_only:false; response_revision:20272; number_of_response:1; }","duration":"760.259014ms","start":"2026-08-19T21:08:55.729257Z","end":"2026-08-19T21:08:56.489516Z","steps":["trace[1322706758] 'process raft request'  (duration: 759.534126ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:08:56.48958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:08:55.729248Z","time spent":"760.305316ms","remote":"127.0.0.1:43946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:20261 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-19T21:08:56.489295Z","caller":"traceutil/trace.go:171","msg":"trace[1751613952] transaction","detail":"{read_only:false; response_revision:20270; number_of_response:1; }","duration":"760.863689ms","start":"2026-08-19T21:08:55.728419Z","end":"2026-08-19T21:08:56.489283Z","steps":["trace[1751613952] 'process raft request'  (duration: 760.286575ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:08:56.489792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:08:55.728381Z","time spent":"761.357571ms","remote":"127.0.0.1:43946","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:20260 > 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-08-19T21:08:56.753156Z","caller":"traceutil/trace.go:171","msg":"trace[594171663] linearizableReadLoop","detail":"{readStateIndex:20966; appliedIndex:20964; }","duration":"259.512761ms","start":"2026-08-19T21:08:56.493625Z","end":"2026-08-19T21:08:56.753138Z","steps":["trace[594171663] 'read index received'  (duration: 259.271825ms)","trace[594171663] 'applied index is now lower than readState.Index'  (duration: 240.146µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:08:56.753286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.641694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:08:56.753321Z","caller":"traceutil/trace.go:171","msg":"trace[10454612] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20274; }","duration":"259.732186ms","start":"2026-08-19T21:08:56.49358Z","end":"2026-08-19T21:08:56.753313Z","steps":["trace[10454612] 'agreement among raft nodes before linearized reading'  (duration: 259.641404ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:08:56.753633Z","caller":"traceutil/trace.go:171","msg":"trace[1776965657] transaction","detail":"{read_only:false; response_revision:20273; number_of_response:1; }","duration":"351.1813ms","start":"2026-08-19T21:08:56.40244Z","end":"2026-08-19T21:08:56.753621Z","steps":["trace[1776965657] 'process raft request'  (duration: 350.511923ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:08:56.753732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:08:56.402404Z","time spent":"351.264673ms","remote":"127.0.0.1:43946","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:20263 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-08-19T21:08:56.753925Z","caller":"traceutil/trace.go:171","msg":"trace[136869492] transaction","detail":"{read_only:false; response_revision:20274; number_of_response:1; }","duration":"351.294923ms","start":"2026-08-19T21:08:56.402608Z","end":"2026-08-19T21:08:56.753903Z","steps":["trace[136869492] 'process raft request'  (duration: 350.470482ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:08:56.75403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:08:56.402584Z","time spent":"351.395055ms","remote":"127.0.0.1:43946","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:20264 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-19T21:08:57.02224Z","caller":"traceutil/trace.go:171","msg":"trace[1888064318] transaction","detail":"{read_only:false; response_revision:20275; number_of_response:1; }","duration":"150.914806ms","start":"2026-08-19T21:08:56.871301Z","end":"2026-08-19T21:08:57.022216Z","steps":["trace[1888064318] 'process raft request'  (duration: 150.174798ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:08:57.416718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.175466ms","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-08-19T21:08:57.416929Z","caller":"traceutil/trace.go:171","msg":"trace[1467760194] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:20275; }","duration":"275.433743ms","start":"2026-08-19T21:08:57.14147Z","end":"2026-08-19T21:08:57.416904Z","steps":["trace[1467760194] 'range keys from in-memory index tree'  (duration: 274.968152ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:08:57.595712Z","caller":"traceutil/trace.go:171","msg":"trace[1263027465] transaction","detail":"{read_only:false; response_revision:20276; number_of_response:1; }","duration":"102.818192ms","start":"2026-08-19T21:08:57.492867Z","end":"2026-08-19T21:08:57.595685Z","steps":["trace[1263027465] 'process raft request'  (duration: 102.402632ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:12:45.940653Z","caller":"traceutil/trace.go:171","msg":"trace[671856301] transaction","detail":"{read_only:false; response_revision:22719; number_of_response:1; }","duration":"203.689968ms","start":"2026-08-19T21:12:45.736929Z","end":"2026-08-19T21:12:45.940619Z","steps":["trace[671856301] 'process raft request'  (duration: 203.478613ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:12:45.941691Z","caller":"traceutil/trace.go:171","msg":"trace[276407900] transaction","detail":"{read_only:false; response_revision:22720; number_of_response:1; }","duration":"187.381281ms","start":"2026-08-19T21:12:45.754279Z","end":"2026-08-19T21:12:45.94166Z","steps":["trace[276407900] 'process raft request'  (duration: 186.986781ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:12:45.941801Z","caller":"traceutil/trace.go:171","msg":"trace[160634344] linearizableReadLoop","detail":"{readStateIndex:23491; appliedIndex:23489; }","duration":"177.845369ms","start":"2026-08-19T21:12:45.763927Z","end":"2026-08-19T21:12:45.941773Z","steps":["trace[160634344] 'read index received'  (duration: 176.562938ms)","trace[160634344] 'applied index is now lower than readState.Index'  (duration: 1.281511ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:12:45.942046Z","caller":"traceutil/trace.go:171","msg":"trace[389490818] transaction","detail":"{read_only:false; response_revision:22721; number_of_response:1; }","duration":"175.929242ms","start":"2026-08-19T21:12:45.766107Z","end":"2026-08-19T21:12:45.942036Z","steps":["trace[389490818] 'process raft request'  (duration: 175.305877ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:12:45.942271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.628952ms","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-08-19T21:12:45.942316Z","caller":"traceutil/trace.go:171","msg":"trace[1956803086] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22721; }","duration":"172.749934ms","start":"2026-08-19T21:12:45.769556Z","end":"2026-08-19T21:12:45.942306Z","steps":["trace[1956803086] 'agreement among raft nodes before linearized reading'  (duration: 172.5689ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:12:45.942394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.455113ms","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-08-19T21:12:45.942434Z","caller":"traceutil/trace.go:171","msg":"trace[1383621824] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22721; }","duration":"178.515154ms","start":"2026-08-19T21:12:45.763911Z","end":"2026-08-19T21:12:45.942426Z","steps":["trace[1383621824] 'agreement among raft nodes before linearized reading'  (duration: 178.35523ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:12:45.942455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.733911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"warn","ts":"2026-08-19T21:12:45.942494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.689676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-08-19T21:12:45.94253Z","caller":"traceutil/trace.go:171","msg":"trace[1382196544] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22721; }","duration":"168.781819ms","start":"2026-08-19T21:12:45.773738Z","end":"2026-08-19T21:12:45.94252Z","steps":["trace[1382196544] 'agreement among raft nodes before linearized reading'  (duration: 168.630714ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:12:45.942524Z","caller":"traceutil/trace.go:171","msg":"trace[1022737081] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22721; }","duration":"148.843574ms","start":"2026-08-19T21:12:45.793663Z","end":"2026-08-19T21:12:45.942506Z","steps":["trace[1022737081] 'agreement among raft nodes before linearized reading'  (duration: 148.677089ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:13:41.490746Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20195}
{"level":"info","ts":"2026-08-19T21:13:41.612201Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20195,"took":"116.22226ms","hash":3835508095,"current-db-size-bytes":58052608,"current-db-size":"58 MB","current-db-size-in-use-bytes":43024384,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-08-19T21:13:41.61229Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3835508095,"revision":20195,"compact-revision":17875}
{"level":"info","ts":"2026-08-19T21:18:41.497042Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23383}
{"level":"info","ts":"2026-08-19T21:18:41.634476Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23383,"took":"133.126412ms","hash":1770023750,"current-db-size-bytes":58052608,"current-db-size":"58 MB","current-db-size-in-use-bytes":32083968,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-19T21:18:41.634541Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1770023750,"revision":23383,"compact-revision":20195}
{"level":"info","ts":"2026-08-19T21:21:07.57871Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006c03.wal"}