{"level":"warn","ts":"2026-10-15T06:36:49.593872Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-15T06:36:49.594014Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.116: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.116:2380","--initial-cluster=instance=https://199.19.213.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.116:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-10-15T06:36:49.594122Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-15T06:36:49.594139Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.116:2380"]}
{"level":"info","ts":"2026-10-15T06:36:49.594166Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-10-15T06:36:49.595079Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.116:2379"]}
{"level":"info","ts":"2026-10-15T06:36:49.595189Z","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.116:2380"],"listen-peer-urls":["https://199.19.213.116:2380"],"advertise-client-urls":["https://199.19.213.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.116:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-10-15T06:36:49.600094Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.552728ms"}
{"level":"info","ts":"2026-10-15T06:36:49.609245Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ca739d563b259b56","cluster-id":"2052ec4484eed829"}
{"level":"info","ts":"2026-10-15T06:36:49.609397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 switched to configuration voters=()"}
{"level":"info","ts":"2026-10-15T06:36:49.609436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 became follower at term 0"}
{"level":"info","ts":"2026-10-15T06:36:49.609452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ca739d563b259b56 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-15T06:36:49.609466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 became follower at term 1"}
{"level":"info","ts":"2026-10-15T06:36:49.609537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 switched to configuration voters=(14588176611668237142)"}
{"level":"warn","ts":"2026-10-15T06:36:49.62182Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-15T06:36:49.627581Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-15T06:36:49.630397Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-10-15T06:36:49.634721Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ca739d563b259b56","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-15T06:36:49.634989Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ca739d563b259b56","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-15T06:36:49.635095Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-10-15T06:36:49.63532Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-10-15T06:36:49.635353Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-10-15T06:36:49.638199Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 switched to configuration voters=(14588176611668237142)"}
{"level":"info","ts":"2026-10-15T06:36:49.63839Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2052ec4484eed829","local-member-id":"ca739d563b259b56","added-peer-id":"ca739d563b259b56","added-peer-peer-urls":["https://199.19.213.116:2380"]}
{"level":"info","ts":"2026-10-15T06:36:49.642617Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-10-15T06:36:49.642725Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.116:2380"}
{"level":"info","ts":"2026-10-15T06:36:49.642779Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.116:2380"}
{"level":"info","ts":"2026-10-15T06:36:49.643495Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ca739d563b259b56","initial-advertise-peer-urls":["https://199.19.213.116:2380"],"listen-peer-urls":["https://199.19.213.116:2380"],"advertise-client-urls":["https://199.19.213.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-15T06:36:49.643572Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-15T06:36:50.110021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 is starting a new election at term 1"}
{"level":"info","ts":"2026-10-15T06:36:50.11011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-15T06:36:50.110135Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 received MsgPreVoteResp from ca739d563b259b56 at term 1"}
{"level":"info","ts":"2026-10-15T06:36:50.110154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 became candidate at term 2"}
{"level":"info","ts":"2026-10-15T06:36:50.110165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 received MsgVoteResp from ca739d563b259b56 at term 2"}
{"level":"info","ts":"2026-10-15T06:36:50.11018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ca739d563b259b56 became leader at term 2"}
{"level":"info","ts":"2026-10-15T06:36:50.110192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ca739d563b259b56 elected leader ca739d563b259b56 at term 2"}
{"level":"info","ts":"2026-10-15T06:36:50.121032Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ca739d563b259b56","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.116:2379]}","request-path":"/0/members/ca739d563b259b56/attributes","cluster-id":"2052ec4484eed829","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-15T06:36:50.121104Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-15T06:36:50.121255Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-15T06:36:50.121262Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-15T06:36:50.121583Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-15T06:36:50.121704Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-15T06:36:50.123683Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.116:2379"}
{"level":"info","ts":"2026-10-15T06:36:50.125035Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-15T06:36:50.12519Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2052ec4484eed829","local-member-id":"ca739d563b259b56","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-15T06:36:50.125315Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-15T06:36:50.125395Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-15T06:37:07.098699Z","caller":"traceutil/trace.go:171","msg":"trace[630429461] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"298.849528ms","start":"2026-10-15T06:37:06.799819Z","end":"2026-10-15T06:37:07.098668Z","steps":["trace[630429461] 'process raft request'  (duration: 265.928094ms)","trace[630429461] 'compare'  (duration: 32.74828ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T06:37:07.098695Z","caller":"traceutil/trace.go:171","msg":"trace[122675340] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:427; }","duration":"173.456717ms","start":"2026-10-15T06:37:06.925202Z","end":"2026-10-15T06:37:07.098659Z","steps":["trace[122675340] 'read index received'  (duration: 140.540693ms)","trace[122675340] 'applied index is now lower than readState.Index'  (duration: 32.914634ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T06:37:07.098844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.620022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-15T06:37:07.098973Z","caller":"traceutil/trace.go:171","msg":"trace[98667935] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:416; }","duration":"173.829307ms","start":"2026-10-15T06:37:06.925131Z","end":"2026-10-15T06:37:07.098961Z","steps":["trace[98667935] 'agreement among raft nodes before linearized reading'  (duration: 173.641422ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:37:07.246284Z","caller":"traceutil/trace.go:171","msg":"trace[737297047] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"135.0008ms","start":"2026-10-15T06:37:07.11125Z","end":"2026-10-15T06:37:07.246251Z","steps":["trace[737297047] 'process raft request'  (duration: 134.60361ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:37:43.232683Z","caller":"traceutil/trace.go:171","msg":"trace[603331370] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:675; }","duration":"182.730486ms","start":"2026-10-15T06:37:43.049912Z","end":"2026-10-15T06:37:43.232642Z","steps":["trace[603331370] 'read index received'  (duration: 101.152619ms)","trace[603331370] 'applied index is now lower than readState.Index'  (duration: 81.576987ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T06:37:43.232921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.989284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-10-15T06:37:43.232962Z","caller":"traceutil/trace.go:171","msg":"trace[1289577985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:654; }","duration":"183.093336ms","start":"2026-10-15T06:37:43.049856Z","end":"2026-10-15T06:37:43.23295Z","steps":["trace[1289577985] 'agreement among raft nodes before linearized reading'  (duration: 182.919232ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:37:43.233053Z","caller":"traceutil/trace.go:171","msg":"trace[1706355477] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"200.533743ms","start":"2026-10-15T06:37:43.032476Z","end":"2026-10-15T06:37:43.233009Z","steps":["trace[1706355477] 'process raft request'  (duration: 118.573346ms)","trace[1706355477] 'compare'  (duration: 81.443403ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T06:37:43.446416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.443976ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11193311212728897135 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:994 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-10-15T06:37:43.44668Z","caller":"traceutil/trace.go:171","msg":"trace[1006855810] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"205.930644ms","start":"2026-10-15T06:37:43.240713Z","end":"2026-10-15T06:37:43.446644Z","steps":["trace[1006855810] 'process raft request'  (duration: 205.836392ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:37:43.446668Z","caller":"traceutil/trace.go:171","msg":"trace[1161513845] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"375.296931ms","start":"2026-10-15T06:37:43.071327Z","end":"2026-10-15T06:37:43.446624Z","steps":["trace[1161513845] 'process raft request'  (duration: 262.121316ms)","trace[1161513845] 'compare'  (duration: 112.219309ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T06:37:43.446835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:37:43.071152Z","time spent":"375.606168ms","remote":"127.0.0.1:42004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:994 >> failure:<>"}
{"level":"warn","ts":"2026-10-15T06:37:43.878299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.429856ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11193311212728897140 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:642 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-15T06:37:43.878607Z","caller":"traceutil/trace.go:171","msg":"trace[292285869] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:678; }","duration":"187.511242ms","start":"2026-10-15T06:37:43.691079Z","end":"2026-10-15T06:37:43.87859Z","steps":["trace[292285869] 'read index received'  (duration: 48.590893ms)","trace[292285869] 'applied index is now lower than readState.Index'  (duration: 138.918879ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T06:37:43.878674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.601924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.116\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-10-15T06:37:43.878663Z","caller":"traceutil/trace.go:171","msg":"trace[50192103] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"401.614951ms","start":"2026-10-15T06:37:43.47701Z","end":"2026-10-15T06:37:43.878625Z","steps":["trace[50192103] 'process raft request'  (duration: 262.63705ms)","trace[50192103] 'compare'  (duration: 138.312374ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T06:37:43.878701Z","caller":"traceutil/trace.go:171","msg":"trace[73186966] range","detail":"{range_begin:/registry/masterleases/199.19.213.116; range_end:; response_count:1; response_revision:657; }","duration":"187.671965ms","start":"2026-10-15T06:37:43.691018Z","end":"2026-10-15T06:37:43.87869Z","steps":["trace[73186966] 'agreement among raft nodes before linearized reading'  (duration: 187.614254ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:37:43.87885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:37:43.476968Z","time spent":"401.777565ms","remote":"127.0.0.1:41924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:642 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-10-15T06:37:59.282713Z","caller":"traceutil/trace.go:171","msg":"trace[501380741] transaction","detail":"{read_only:false; response_revision:822; number_of_response:1; }","duration":"160.800603ms","start":"2026-10-15T06:37:59.121887Z","end":"2026-10-15T06:37:59.282687Z","steps":["trace[501380741] 'process raft request'  (duration: 160.621917ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:38:31.017475Z","caller":"traceutil/trace.go:171","msg":"trace[596114230] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"245.012058ms","start":"2026-10-15T06:38:30.772423Z","end":"2026-10-15T06:38:31.017435Z","steps":["trace[596114230] 'process raft request'  (duration: 244.768392ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:39:17.612075Z","caller":"traceutil/trace.go:171","msg":"trace[462968072] linearizableReadLoop","detail":"{readStateIndex:1939; appliedIndex:1938; }","duration":"169.57419ms","start":"2026-10-15T06:39:17.442471Z","end":"2026-10-15T06:39:17.612045Z","steps":["trace[462968072] 'read index received'  (duration: 169.480237ms)","trace[462968072] 'applied index is now lower than readState.Index'  (duration: 92.743µs)"],"step_count":2}
{"level":"info","ts":"2026-10-15T06:39:17.612212Z","caller":"traceutil/trace.go:171","msg":"trace[1572435668] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"266.214268ms","start":"2026-10-15T06:39:17.345938Z","end":"2026-10-15T06:39:17.612153Z","steps":["trace[1572435668] 'process raft request'  (duration: 265.898979ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:39:17.612456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.94782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:567"}
{"level":"info","ts":"2026-10-15T06:39:17.612538Z","caller":"traceutil/trace.go:171","msg":"trace[903458584] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1883; }","duration":"170.084993ms","start":"2026-10-15T06:39:17.442426Z","end":"2026-10-15T06:39:17.612511Z","steps":["trace[903458584] 'agreement among raft nodes before linearized reading'  (duration: 169.749994ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:39:17.744567Z","caller":"traceutil/trace.go:171","msg":"trace[1191716405] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"126.363098ms","start":"2026-10-15T06:39:17.618158Z","end":"2026-10-15T06:39:17.744522Z","steps":["trace[1191716405] 'process raft request'  (duration: 74.351308ms)","trace[1191716405] 'compare'  (duration: 51.798405ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T06:39:17.749769Z","caller":"traceutil/trace.go:171","msg":"trace[30829459] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"122.96163ms","start":"2026-10-15T06:39:17.626757Z","end":"2026-10-15T06:39:17.749719Z","steps":["trace[30829459] 'process raft request'  (duration: 122.755345ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:40:00.093696Z","caller":"traceutil/trace.go:171","msg":"trace[940873583] linearizableReadLoop","detail":"{readStateIndex:2294; appliedIndex:2293; }","duration":"223.918438ms","start":"2026-10-15T06:39:59.869744Z","end":"2026-10-15T06:40:00.093662Z","steps":["trace[940873583] 'read index received'  (duration: 223.754954ms)","trace[940873583] 'applied index is now lower than readState.Index'  (duration: 162.424µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T06:40:00.093862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.105563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-10-15T06:40:00.093894Z","caller":"traceutil/trace.go:171","msg":"trace[718551725] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2219; }","duration":"224.196215ms","start":"2026-10-15T06:39:59.86969Z","end":"2026-10-15T06:40:00.093886Z","steps":["trace[718551725] 'agreement among raft nodes before linearized reading'  (duration: 224.064851ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:40:00.093717Z","caller":"traceutil/trace.go:171","msg":"trace[1778899702] transaction","detail":"{read_only:false; response_revision:2219; number_of_response:1; }","duration":"363.998857ms","start":"2026-10-15T06:39:59.729703Z","end":"2026-10-15T06:40:00.093702Z","steps":["trace[1778899702] 'process raft request'  (duration: 363.798432ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:40:00.094225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:39:59.729665Z","time spent":"364.474359ms","remote":"127.0.0.1:41826","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8641,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:2002 > success:<request_put:<key:\"/registry/minions/instance\" value_size:8607 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-10-15T06:40:00.289972Z","caller":"traceutil/trace.go:171","msg":"trace[627456424] linearizableReadLoop","detail":"{readStateIndex:2295; appliedIndex:2294; }","duration":"196.146196ms","start":"2026-10-15T06:40:00.093797Z","end":"2026-10-15T06:40:00.289943Z","steps":["trace[627456424] 'read index received'  (duration: 154.116904ms)","trace[627456424] 'applied index is now lower than readState.Index'  (duration: 42.028262ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T06:40:00.290089Z","caller":"traceutil/trace.go:171","msg":"trace[331926022] transaction","detail":"{read_only:false; response_revision:2220; number_of_response:1; }","duration":"268.776834ms","start":"2026-10-15T06:40:00.021301Z","end":"2026-10-15T06:40:00.290078Z","steps":["trace[331926022] 'process raft request'  (duration: 226.633689ms)","trace[331926022] 'compare'  (duration: 41.883018ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T06:40:00.290283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.104469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-15T06:40:00.290381Z","caller":"traceutil/trace.go:171","msg":"trace[423695662] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2220; }","duration":"367.260283ms","start":"2026-10-15T06:39:59.923102Z","end":"2026-10-15T06:40:00.290362Z","steps":["trace[423695662] 'agreement among raft nodes before linearized reading'  (duration: 367.043947ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:40:00.290416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:39:59.923075Z","time spent":"367.334674ms","remote":"127.0.0.1:41646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-10-15T06:40:00.292334Z","caller":"traceutil/trace.go:171","msg":"trace[233789348] transaction","detail":"{read_only:false; response_revision:2221; number_of_response:1; }","duration":"192.919463ms","start":"2026-10-15T06:40:00.09938Z","end":"2026-10-15T06:40:00.292299Z","steps":["trace[233789348] 'process raft request'  (duration: 192.610735ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:40:00.474971Z","caller":"traceutil/trace.go:171","msg":"trace[1757233038] transaction","detail":"{read_only:false; response_revision:2225; number_of_response:1; }","duration":"140.568962ms","start":"2026-10-15T06:40:00.334368Z","end":"2026-10-15T06:40:00.474937Z","steps":["trace[1757233038] 'process raft request'  (duration: 140.388987ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:40:40.646547Z","caller":"traceutil/trace.go:171","msg":"trace[553783305] linearizableReadLoop","detail":"{readStateIndex:2641; appliedIndex:2640; }","duration":"123.710574ms","start":"2026-10-15T06:40:40.522806Z","end":"2026-10-15T06:40:40.646516Z","steps":["trace[553783305] 'read index received'  (duration: 123.414737ms)","trace[553783305] 'applied index is now lower than readState.Index'  (duration: 294.167µs)"],"step_count":2}
{"level":"info","ts":"2026-10-15T06:40:40.646635Z","caller":"traceutil/trace.go:171","msg":"trace[1984298041] transaction","detail":"{read_only:false; response_revision:2548; number_of_response:1; }","duration":"137.934223ms","start":"2026-10-15T06:40:40.508669Z","end":"2026-10-15T06:40:40.646603Z","steps":["trace[1984298041] 'process raft request'  (duration: 137.614385ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:40:40.646835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.000401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-10-15T06:40:40.646953Z","caller":"traceutil/trace.go:171","msg":"trace[2136352193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2548; }","duration":"124.176506ms","start":"2026-10-15T06:40:40.522757Z","end":"2026-10-15T06:40:40.646934Z","steps":["trace[2136352193] 'agreement among raft nodes before linearized reading'  (duration: 123.880228ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:41:07.49759Z","caller":"traceutil/trace.go:171","msg":"trace[640212551] transaction","detail":"{read_only:false; response_revision:2739; number_of_response:1; }","duration":"104.460947ms","start":"2026-10-15T06:41:07.393097Z","end":"2026-10-15T06:41:07.497558Z","steps":["trace[640212551] 'process raft request'  (duration: 63.07605ms)","trace[640212551] 'compare'  (duration: 40.938436ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T06:41:12.910143Z","caller":"traceutil/trace.go:171","msg":"trace[224591591] transaction","detail":"{read_only:false; response_revision:2770; number_of_response:1; }","duration":"100.373921ms","start":"2026-10-15T06:41:12.809719Z","end":"2026-10-15T06:41:12.910093Z","steps":["trace[224591591] 'process raft request'  (duration: 100.113325ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:41:13.170422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.998435ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11193311212728901889 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2757 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-15T06:41:13.170755Z","caller":"traceutil/trace.go:171","msg":"trace[1676654749] transaction","detail":"{read_only:false; response_revision:2771; number_of_response:1; }","duration":"255.288912ms","start":"2026-10-15T06:41:12.915441Z","end":"2026-10-15T06:41:13.17073Z","steps":["trace[1676654749] 'process raft request'  (duration: 122.831866ms)","trace[1676654749] 'compare'  (duration: 131.799399ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T06:41:13.171039Z","caller":"traceutil/trace.go:171","msg":"trace[1914687471] transaction","detail":"{read_only:false; response_revision:2772; number_of_response:1; }","duration":"255.334233ms","start":"2026-10-15T06:41:12.915669Z","end":"2026-10-15T06:41:13.171003Z","steps":["trace[1914687471] 'process raft request'  (duration: 255.005364ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:42:30.595711Z","caller":"traceutil/trace.go:171","msg":"trace[1460368187] transaction","detail":"{read_only:false; response_revision:3463; number_of_response:1; }","duration":"143.996004ms","start":"2026-10-15T06:42:30.451679Z","end":"2026-10-15T06:42:30.595675Z","steps":["trace[1460368187] 'process raft request'  (duration: 143.758858ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:42:30.722237Z","caller":"traceutil/trace.go:171","msg":"trace[1529879866] transaction","detail":"{read_only:false; response_revision:3464; number_of_response:1; }","duration":"120.424609ms","start":"2026-10-15T06:42:30.601781Z","end":"2026-10-15T06:42:30.722206Z","steps":["trace[1529879866] 'process raft request'  (duration: 76.31798ms)","trace[1529879866] 'compare'  (duration: 43.959185ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T06:42:30.722767Z","caller":"traceutil/trace.go:171","msg":"trace[422912247] transaction","detail":"{read_only:false; response_revision:3465; number_of_response:1; }","duration":"119.856604ms","start":"2026-10-15T06:42:30.602875Z","end":"2026-10-15T06:42:30.722731Z","steps":["trace[422912247] 'process raft request'  (duration: 119.70854ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:43:49.168055Z","caller":"traceutil/trace.go:171","msg":"trace[749390250] transaction","detail":"{read_only:false; response_revision:4496; number_of_response:1; }","duration":"131.048575ms","start":"2026-10-15T06:43:49.036915Z","end":"2026-10-15T06:43:49.167964Z","steps":["trace[749390250] 'process raft request'  (duration: 99.430761ms)","trace[749390250] 'compare'  (duration: 30.471284ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T06:43:59.764917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.103748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/storage-loki-0.18dea0ec430bc484\" ","response":"range_response_count:1 size:943"}
{"level":"info","ts":"2026-10-15T06:43:59.765084Z","caller":"traceutil/trace.go:171","msg":"trace[2046189906] range","detail":"{range_begin:/registry/events/monitoring/storage-loki-0.18dea0ec430bc484; range_end:; response_count:1; response_revision:4764; }","duration":"157.286932ms","start":"2026-10-15T06:43:59.607727Z","end":"2026-10-15T06:43:59.765014Z","steps":["trace[2046189906] 'range keys from in-memory index tree'  (duration: 156.875303ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:44:00.1326Z","caller":"traceutil/trace.go:171","msg":"trace[1055594927] transaction","detail":"{read_only:false; response_revision:4770; number_of_response:1; }","duration":"201.919012ms","start":"2026-10-15T06:43:59.930639Z","end":"2026-10-15T06:44:00.132558Z","steps":["trace[1055594927] 'process raft request'  (duration: 201.693066ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:44:00.150619Z","caller":"traceutil/trace.go:171","msg":"trace[471818969] transaction","detail":"{read_only:false; response_revision:4771; number_of_response:1; }","duration":"183.303547ms","start":"2026-10-15T06:43:59.967282Z","end":"2026-10-15T06:44:00.150585Z","steps":["trace[471818969] 'process raft request'  (duration: 183.079001ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:44:00.150822Z","caller":"traceutil/trace.go:171","msg":"trace[302692305] transaction","detail":"{read_only:false; response_revision:4772; number_of_response:1; }","duration":"163.239917ms","start":"2026-10-15T06:43:59.987554Z","end":"2026-10-15T06:44:00.150794Z","steps":["trace[302692305] 'process raft request'  (duration: 162.97785ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:44:00.350056Z","caller":"traceutil/trace.go:171","msg":"trace[2015021965] linearizableReadLoop","detail":"{readStateIndex:4975; appliedIndex:4973; }","duration":"181.680096ms","start":"2026-10-15T06:44:00.168337Z","end":"2026-10-15T06:44:00.350017Z","steps":["trace[2015021965] 'read index received'  (duration: 7.404861ms)","trace[2015021965] 'applied index is now lower than readState.Index'  (duration: 174.273945ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T06:44:00.350279Z","caller":"traceutil/trace.go:171","msg":"trace[933612865] transaction","detail":"{read_only:false; response_revision:4774; number_of_response:1; }","duration":"192.072246ms","start":"2026-10-15T06:44:00.158196Z","end":"2026-10-15T06:44:00.350269Z","steps":["trace[933612865] 'process raft request'  (duration: 191.722817ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:44:00.35072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.359213ms","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-10-15T06:44:00.35083Z","caller":"traceutil/trace.go:171","msg":"trace[1682459387] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4774; }","duration":"182.508347ms","start":"2026-10-15T06:44:00.168298Z","end":"2026-10-15T06:44:00.350806Z","steps":["trace[1682459387] 'agreement among raft nodes before linearized reading'  (duration: 182.201289ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:44:00.365074Z","caller":"traceutil/trace.go:171","msg":"trace[1428603530] transaction","detail":"{read_only:false; response_revision:4775; number_of_response:1; }","duration":"168.622077ms","start":"2026-10-15T06:44:00.196389Z","end":"2026-10-15T06:44:00.365011Z","steps":["trace[1428603530] 'process raft request'  (duration: 168.406411ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:44:00.365376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.790333ms","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-10-15T06:44:00.365387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.057746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-10-15T06:44:00.365477Z","caller":"traceutil/trace.go:171","msg":"trace[1742423409] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4775; }","duration":"185.968267ms","start":"2026-10-15T06:44:00.179488Z","end":"2026-10-15T06:44:00.365456Z","steps":["trace[1742423409] 'agreement among raft nodes before linearized reading'  (duration: 185.616288ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:44:00.365511Z","caller":"traceutil/trace.go:171","msg":"trace[1280294918] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4775; }","duration":"110.233581ms","start":"2026-10-15T06:44:00.255241Z","end":"2026-10-15T06:44:00.365474Z","steps":["trace[1280294918] 'agreement among raft nodes before linearized reading'  (duration: 109.82776ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:44:16.257113Z","caller":"traceutil/trace.go:171","msg":"trace[1754310480] linearizableReadLoop","detail":"{readStateIndex:5302; appliedIndex:5301; }","duration":"144.134542ms","start":"2026-10-15T06:44:16.112939Z","end":"2026-10-15T06:44:16.257073Z","steps":["trace[1754310480] 'read index received'  (duration: 144.016139ms)","trace[1754310480] 'applied index is now lower than readState.Index'  (duration: 116.513µs)"],"step_count":2}
{"level":"info","ts":"2026-10-15T06:44:16.257257Z","caller":"traceutil/trace.go:171","msg":"trace[793121708] transaction","detail":"{read_only:false; response_revision:5087; number_of_response:1; }","duration":"267.02843ms","start":"2026-10-15T06:44:15.99018Z","end":"2026-10-15T06:44:16.257209Z","steps":["trace[793121708] 'process raft request'  (duration: 266.680611ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:44:16.257518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.541772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"}
{"level":"info","ts":"2026-10-15T06:44:16.257604Z","caller":"traceutil/trace.go:171","msg":"trace[1880018874] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5087; }","duration":"144.706237ms","start":"2026-10-15T06:44:16.112874Z","end":"2026-10-15T06:44:16.25758Z","steps":["trace[1880018874] 'agreement among raft nodes before linearized reading'  (duration: 144.42402ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:44:16.509487Z","caller":"traceutil/trace.go:171","msg":"trace[1092668718] linearizableReadLoop","detail":"{readStateIndex:5303; appliedIndex:5302; }","duration":"252.188507ms","start":"2026-10-15T06:44:16.257252Z","end":"2026-10-15T06:44:16.50944Z","steps":["trace[1092668718] 'read index received'  (duration: 203.949745ms)","trace[1092668718] 'applied index is now lower than readState.Index'  (duration: 48.236932ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T06:44:16.509549Z","caller":"traceutil/trace.go:171","msg":"trace[1724435272] transaction","detail":"{read_only:false; response_revision:5088; number_of_response:1; }","duration":"295.039278ms","start":"2026-10-15T06:44:16.214469Z","end":"2026-10-15T06:44:16.509508Z","steps":["trace[1724435272] 'process raft request'  (duration: 246.673233ms)","trace[1724435272] 'compare'  (duration: 47.988776ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T06:44:16.509891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.47582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:567"}
{"level":"info","ts":"2026-10-15T06:44:16.50994Z","caller":"traceutil/trace.go:171","msg":"trace[3521893] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5088; }","duration":"248.613364ms","start":"2026-10-15T06:44:16.261311Z","end":"2026-10-15T06:44:16.509925Z","steps":["trace[3521893] 'agreement among raft nodes before linearized reading'  (duration: 248.43798ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:44:16.509894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.486994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:2102"}
{"level":"info","ts":"2026-10-15T06:44:16.510213Z","caller":"traceutil/trace.go:171","msg":"trace[1536946773] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:5088; }","duration":"368.824913ms","start":"2026-10-15T06:44:16.14131Z","end":"2026-10-15T06:44:16.510135Z","steps":["trace[1536946773] 'agreement among raft nodes before linearized reading'  (duration: 368.366712ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:44:16.510274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.089871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:645"}
{"level":"info","ts":"2026-10-15T06:44:16.51038Z","caller":"traceutil/trace.go:171","msg":"trace[912967323] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5088; }","duration":"166.254775ms","start":"2026-10-15T06:44:16.344094Z","end":"2026-10-15T06:44:16.510349Z","steps":["trace[912967323] 'agreement among raft nodes before linearized reading'  (duration: 165.953937ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:44:16.510385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:44:16.141278Z","time spent":"369.051319ms","remote":"127.0.0.1:52004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":1,"response size":2125,"request content":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" "}
{"level":"info","ts":"2026-10-15T06:46:50.159195Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3028}
{"level":"info","ts":"2026-10-15T06:46:50.262429Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3028,"took":"101.177153ms","hash":2925395232,"current-db-size-bytes":60395520,"current-db-size":"60 MB","current-db-size-in-use-bytes":33824768,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-10-15T06:46:50.262524Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2925395232,"revision":3028,"compact-revision":-1}
{"level":"info","ts":"2026-10-15T06:49:00.960355Z","caller":"traceutil/trace.go:171","msg":"trace[1668867906] transaction","detail":"{read_only:false; response_revision:7644; number_of_response:1; }","duration":"102.103317ms","start":"2026-10-15T06:49:00.858219Z","end":"2026-10-15T06:49:00.960323Z","steps":["trace[1668867906] 'process raft request'  (duration: 101.480861ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:50:26.249117Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002293.wal"}
{"level":"info","ts":"2026-10-15T06:50:30.044994Z","caller":"traceutil/trace.go:171","msg":"trace[422106959] linearizableReadLoop","detail":"{readStateIndex:8881; appliedIndex:8880; }","duration":"302.216973ms","start":"2026-10-15T06:50:29.742747Z","end":"2026-10-15T06:50:30.044964Z","steps":["trace[422106959] 'read index received'  (duration: 301.980117ms)","trace[422106959] 'applied index is now lower than readState.Index'  (duration: 235.636µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T06:50:30.045285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.523491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"}
{"level":"warn","ts":"2026-10-15T06:50:30.045286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.800945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-15T06:50:30.045339Z","caller":"traceutil/trace.go:171","msg":"trace[1888402741] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8503; }","duration":"302.595463ms","start":"2026-10-15T06:50:29.742724Z","end":"2026-10-15T06:50:30.045319Z","steps":["trace[1888402741] 'agreement among raft nodes before linearized reading'  (duration: 302.385598ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:50:30.045368Z","caller":"traceutil/trace.go:171","msg":"trace[922725396] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8503; }","duration":"121.95273ms","start":"2026-10-15T06:50:29.923388Z","end":"2026-10-15T06:50:30.045341Z","steps":["trace[922725396] 'agreement among raft nodes before linearized reading'  (duration: 121.808426ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:50:30.045341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.48794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-10-15T06:50:30.045422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:50:29.742713Z","time spent":"302.697835ms","remote":"127.0.0.1:41924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":576,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-10-15T06:50:30.045463Z","caller":"traceutil/trace.go:171","msg":"trace[305540437] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:8503; }","duration":"110.646374ms","start":"2026-10-15T06:50:29.93479Z","end":"2026-10-15T06:50:30.045436Z","steps":["trace[305540437] 'agreement among raft nodes before linearized reading'  (duration: 110.379947ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:50:30.045483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.664468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"}
{"level":"info","ts":"2026-10-15T06:50:30.045578Z","caller":"traceutil/trace.go:171","msg":"trace[1058448725] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:8503; }","duration":"174.839042ms","start":"2026-10-15T06:50:29.870719Z","end":"2026-10-15T06:50:30.045558Z","steps":["trace[1058448725] 'agreement among raft nodes before linearized reading'  (duration: 174.432652ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:50:30.046022Z","caller":"traceutil/trace.go:171","msg":"trace[74444460] transaction","detail":"{read_only:false; response_revision:8503; number_of_response:1; }","duration":"304.512044ms","start":"2026-10-15T06:50:29.740595Z","end":"2026-10-15T06:50:30.045107Z","steps":["trace[74444460] 'process raft request'  (duration: 304.120053ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:50:30.046211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:50:29.740558Z","time spent":"305.505919ms","remote":"127.0.0.1:41746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":644,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" mod_revision:8488 > success:<request_put:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" value_size:562 >> failure:<request_range:<key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-15T06:50:42.621912Z","caller":"traceutil/trace.go:171","msg":"trace[1850396933] transaction","detail":"{read_only:false; response_revision:8586; number_of_response:1; }","duration":"337.349682ms","start":"2026-10-15T06:50:42.284507Z","end":"2026-10-15T06:50:42.621857Z","steps":["trace[1850396933] 'process raft request'  (duration: 250.972953ms)","trace[1850396933] 'compare'  (duration: 86.100202ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T06:50:42.622083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:50:42.28448Z","time spent":"337.511956ms","remote":"127.0.0.1:41924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:8573 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-10-15T06:50:43.351005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.998377ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11193311212728917120 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8577 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-15T06:50:43.351112Z","caller":"traceutil/trace.go:171","msg":"trace[2043341784] linearizableReadLoop","detail":"{readStateIndex:8972; appliedIndex:8971; }","duration":"262.504305ms","start":"2026-10-15T06:50:43.088589Z","end":"2026-10-15T06:50:43.351094Z","steps":["trace[2043341784] 'read index received'  (duration: 139.000775ms)","trace[2043341784] 'applied index is now lower than readState.Index'  (duration: 123.50212ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T06:50:43.351198Z","caller":"traceutil/trace.go:171","msg":"trace[1842253908] transaction","detail":"{read_only:false; response_revision:8589; number_of_response:1; }","duration":"401.901611ms","start":"2026-10-15T06:50:42.949286Z","end":"2026-10-15T06:50:43.351188Z","steps":["trace[1842253908] 'process raft request'  (duration: 278.499753ms)","trace[1842253908] 'compare'  (duration: 122.885583ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T06:50:43.351252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:50:42.949257Z","time spent":"401.965623ms","remote":"127.0.0.1:41924","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:8577 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-10-15T06:50:43.351461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.201903ms","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-10-15T06:50:43.351498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.916916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-15T06:50:43.351554Z","caller":"traceutil/trace.go:171","msg":"trace[1039654513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8589; }","duration":"258.350167ms","start":"2026-10-15T06:50:43.093183Z","end":"2026-10-15T06:50:43.351533Z","steps":["trace[1039654513] 'agreement among raft nodes before linearized reading'  (duration: 258.10636ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:50:43.351583Z","caller":"traceutil/trace.go:171","msg":"trace[1421484849] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:8589; }","duration":"102.017478ms","start":"2026-10-15T06:50:43.249547Z","end":"2026-10-15T06:50:43.351564Z","steps":["trace[1421484849] 'agreement among raft nodes before linearized reading'  (duration: 101.873545ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:50:43.351546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.305065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-10-15T06:50:43.351659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.941901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:525"}
{"level":"info","ts":"2026-10-15T06:50:43.351688Z","caller":"traceutil/trace.go:171","msg":"trace[180035247] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:8589; }","duration":"232.50776ms","start":"2026-10-15T06:50:43.119154Z","end":"2026-10-15T06:50:43.351662Z","steps":["trace[180035247] 'agreement among raft nodes before linearized reading'  (duration: 232.271594ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:50:43.351665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.063029ms","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-10-15T06:50:43.351774Z","caller":"traceutil/trace.go:171","msg":"trace[1086971616] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8589; }","duration":"263.237294ms","start":"2026-10-15T06:50:43.088508Z","end":"2026-10-15T06:50:43.351745Z","steps":["trace[1086971616] 'agreement among raft nodes before linearized reading'  (duration: 262.961317ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:50:43.352007Z","caller":"traceutil/trace.go:171","msg":"trace[2136336483] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:8589; }","duration":"249.33688ms","start":"2026-10-15T06:50:43.102654Z","end":"2026-10-15T06:50:43.351991Z","steps":["trace[2136336483] 'agreement among raft nodes before linearized reading'  (duration: 248.780356ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:50:44.009281Z","caller":"traceutil/trace.go:171","msg":"trace[1254716179] transaction","detail":"{read_only:false; number_of_response:0; response_revision:8594; }","duration":"103.522497ms","start":"2026-10-15T06:50:43.905695Z","end":"2026-10-15T06:50:44.009217Z","steps":["trace[1254716179] 'process raft request'  (duration: 97.630433ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:51:11.711287Z","caller":"traceutil/trace.go:171","msg":"trace[301503520] linearizableReadLoop","detail":"{readStateIndex:9229; appliedIndex:9228; }","duration":"171.620298ms","start":"2026-10-15T06:51:11.539637Z","end":"2026-10-15T06:51:11.711258Z","steps":["trace[301503520] 'read index received'  (duration: 171.3062ms)","trace[301503520] 'applied index is now lower than readState.Index'  (duration: 312.988µs)"],"step_count":2}
{"level":"info","ts":"2026-10-15T06:51:11.711346Z","caller":"traceutil/trace.go:171","msg":"trace[1807239867] transaction","detail":"{read_only:false; response_revision:8833; number_of_response:1; }","duration":"179.570695ms","start":"2026-10-15T06:51:11.531738Z","end":"2026-10-15T06:51:11.711309Z","steps":["trace[1807239867] 'process raft request'  (duration: 179.334449ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:51:11.711605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.967062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-15T06:51:11.711652Z","caller":"traceutil/trace.go:171","msg":"trace[1309024364] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:8833; }","duration":"168.366323ms","start":"2026-10-15T06:51:11.543273Z","end":"2026-10-15T06:51:11.71164Z","steps":["trace[1309024364] 'agreement among raft nodes before linearized reading'  (duration: 168.228979ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:51:11.711739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.070437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-10-15T06:51:11.71177Z","caller":"traceutil/trace.go:171","msg":"trace[1334532136] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:8833; }","duration":"152.176469ms","start":"2026-10-15T06:51:11.559585Z","end":"2026-10-15T06:51:11.711761Z","steps":["trace[1334532136] 'agreement among raft nodes before linearized reading'  (duration: 151.993684ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:51:11.71179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.665986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-m4th8\" ","response":"range_response_count:1 size:6524"}
{"level":"warn","ts":"2026-10-15T06:51:11.711858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.251915ms","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-10-15T06:51:11.71193Z","caller":"traceutil/trace.go:171","msg":"trace[1087142176] range","detail":"{range_begin:/registry/pods/openstack/keepalived-m4th8; range_end:; response_count:1; response_revision:8833; }","duration":"130.886502ms","start":"2026-10-15T06:51:11.581014Z","end":"2026-10-15T06:51:11.711901Z","steps":["trace[1087142176] 'agreement among raft nodes before linearized reading'  (duration: 130.558343ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:51:11.711953Z","caller":"traceutil/trace.go:171","msg":"trace[774260104] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8833; }","duration":"156.44517ms","start":"2026-10-15T06:51:11.555486Z","end":"2026-10-15T06:51:11.711931Z","steps":["trace[774260104] 'agreement among raft nodes before linearized reading'  (duration: 156.098051ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:51:11.712552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.906522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-10-15T06:51:11.712605Z","caller":"traceutil/trace.go:171","msg":"trace[1897110184] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8833; }","duration":"172.985334ms","start":"2026-10-15T06:51:11.539608Z","end":"2026-10-15T06:51:11.712593Z","steps":["trace[1897110184] 'agreement among raft nodes before linearized reading'  (duration: 171.815182ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:51:25.714363Z","caller":"traceutil/trace.go:171","msg":"trace[266761922] transaction","detail":"{read_only:false; response_revision:8965; number_of_response:1; }","duration":"158.587497ms","start":"2026-10-15T06:51:25.555702Z","end":"2026-10-15T06:51:25.714289Z","steps":["trace[266761922] 'process raft request'  (duration: 69.366724ms)","trace[266761922] 'compare'  (duration: 88.842613ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T06:51:25.714745Z","caller":"traceutil/trace.go:171","msg":"trace[1453092612] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8966; }","duration":"157.143199ms","start":"2026-10-15T06:51:25.557565Z","end":"2026-10-15T06:51:25.714708Z","steps":["trace[1453092612] 'process raft request'  (duration: 156.622415ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:51:25.714935Z","caller":"traceutil/trace.go:171","msg":"trace[393749729] transaction","detail":"{read_only:false; response_revision:8967; number_of_response:1; }","duration":"150.524687ms","start":"2026-10-15T06:51:25.56433Z","end":"2026-10-15T06:51:25.714855Z","steps":["trace[393749729] 'process raft request'  (duration: 150.244439ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:51:25.961584Z","caller":"traceutil/trace.go:171","msg":"trace[143366593] linearizableReadLoop","detail":"{readStateIndex:9373; appliedIndex:9372; }","duration":"127.288058ms","start":"2026-10-15T06:51:25.834267Z","end":"2026-10-15T06:51:25.961555Z","steps":["trace[143366593] 'read index received'  (duration: 127.091743ms)","trace[143366593] 'applied index is now lower than readState.Index'  (duration: 195.205µs)"],"step_count":2}
{"level":"info","ts":"2026-10-15T06:51:25.961695Z","caller":"traceutil/trace.go:171","msg":"trace[1433221248] transaction","detail":"{read_only:false; response_revision:8968; number_of_response:1; }","duration":"164.933073ms","start":"2026-10-15T06:51:25.796719Z","end":"2026-10-15T06:51:25.961653Z","steps":["trace[1433221248] 'process raft request'  (duration: 164.658206ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:51:25.961901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.89949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"}
{"level":"warn","ts":"2026-10-15T06:51:25.9619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.613317ms","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-10-15T06:51:25.961945Z","caller":"traceutil/trace.go:171","msg":"trace[1313586179] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:8968; }","duration":"111.005793ms","start":"2026-10-15T06:51:25.850928Z","end":"2026-10-15T06:51:25.961933Z","steps":["trace[1313586179] 'agreement among raft nodes before linearized reading'  (duration: 110.802247ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:51:25.961961Z","caller":"traceutil/trace.go:171","msg":"trace[2111298075] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8968; }","duration":"127.72922ms","start":"2026-10-15T06:51:25.834216Z","end":"2026-10-15T06:51:25.961945Z","steps":["trace[2111298075] 'agreement among raft nodes before linearized reading'  (duration: 127.496004ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:51:25.962182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.692869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-10-15T06:51:25.96223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.531365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-m4th8\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-10-15T06:51:25.962286Z","caller":"traceutil/trace.go:171","msg":"trace[862102773] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8968; }","duration":"109.841342ms","start":"2026-10-15T06:51:25.852422Z","end":"2026-10-15T06:51:25.962263Z","steps":["trace[862102773] 'agreement among raft nodes before linearized reading'  (duration: 109.518784ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:51:25.962334Z","caller":"traceutil/trace.go:171","msg":"trace[1346689019] range","detail":"{range_begin:/registry/pods/openstack/keepalived-m4th8; range_end:; response_count:1; response_revision:8968; }","duration":"101.694019ms","start":"2026-10-15T06:51:25.86061Z","end":"2026-10-15T06:51:25.962304Z","steps":["trace[1346689019] 'agreement among raft nodes before linearized reading'  (duration: 101.309399ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:51:26.671594Z","caller":"traceutil/trace.go:171","msg":"trace[1147761432] transaction","detail":"{read_only:false; response_revision:8974; number_of_response:1; }","duration":"146.386347ms","start":"2026-10-15T06:51:26.525179Z","end":"2026-10-15T06:51:26.671565Z","steps":["trace[1147761432] 'process raft request'  (duration: 146.222923ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:51:50.17017Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6511}
{"level":"info","ts":"2026-10-15T06:51:50.293043Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6511,"took":"119.019831ms","hash":26980363,"current-db-size-bytes":60395520,"current-db-size":"60 MB","current-db-size-in-use-bytes":26095616,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-10-15T06:51:50.293127Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":26980363,"revision":6511,"compact-revision":3028}
{"level":"info","ts":"2026-10-15T06:52:19.810312Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ca739d563b259b56","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-15T06:52:19.823209Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-10-15T06:52:19.82333Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"warn","ts":"2026-10-15T06:56:25.895266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.259305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-10-15T06:56:25.895333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.7094ms","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-10-15T06:56:25.89538Z","caller":"traceutil/trace.go:171","msg":"trace[533341839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11967; }","duration":"125.422389ms","start":"2026-10-15T06:56:25.769932Z","end":"2026-10-15T06:56:25.895355Z","steps":["trace[533341839] 'range keys from in-memory index tree'  (duration: 125.03315ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:56:25.895391Z","caller":"traceutil/trace.go:171","msg":"trace[1453956133] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11967; }","duration":"124.800253ms","start":"2026-10-15T06:56:25.770577Z","end":"2026-10-15T06:56:25.895377Z","steps":["trace[1453956133] 'range keys from in-memory index tree'  (duration: 124.583657ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T06:56:25.895266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.896047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-10-15T06:56:25.895538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.772374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"}
{"level":"info","ts":"2026-10-15T06:56:25.895617Z","caller":"traceutil/trace.go:171","msg":"trace[1164653693] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:11967; }","duration":"108.866896ms","start":"2026-10-15T06:56:25.786727Z","end":"2026-10-15T06:56:25.895594Z","steps":["trace[1164653693] 'range keys from in-memory index tree'  (duration: 108.588809ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:56:25.895688Z","caller":"traceutil/trace.go:171","msg":"trace[1283940174] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11967; }","duration":"117.279567ms","start":"2026-10-15T06:56:25.778293Z","end":"2026-10-15T06:56:25.895572Z","steps":["trace[1283940174] 'range keys from in-memory index tree'  (duration: 116.676541ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:56:26.079081Z","caller":"traceutil/trace.go:171","msg":"trace[1392540269] transaction","detail":"{read_only:false; response_revision:11969; number_of_response:1; }","duration":"178.273773ms","start":"2026-10-15T06:56:25.900779Z","end":"2026-10-15T06:56:26.079053Z","steps":["trace[1392540269] 'process raft request'  (duration: 154.137681ms)","trace[1392540269] 'compare'  (duration: 23.934917ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T06:56:26.079407Z","caller":"traceutil/trace.go:171","msg":"trace[1306986141] transaction","detail":"{read_only:false; response_revision:11970; number_of_response:1; }","duration":"178.032665ms","start":"2026-10-15T06:56:25.901357Z","end":"2026-10-15T06:56:26.079389Z","steps":["trace[1306986141] 'process raft request'  (duration: 177.654236ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:56:26.079465Z","caller":"traceutil/trace.go:171","msg":"trace[2085200573] transaction","detail":"{read_only:false; response_revision:11971; number_of_response:1; }","duration":"177.716068ms","start":"2026-10-15T06:56:25.901721Z","end":"2026-10-15T06:56:26.079437Z","steps":["trace[2085200573] 'process raft request'  (duration: 177.568184ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:56:26.079453Z","caller":"traceutil/trace.go:171","msg":"trace[1760983525] linearizableReadLoop","detail":"{readStateIndex:12508; appliedIndex:12504; }","duration":"155.99938ms","start":"2026-10-15T06:56:25.923421Z","end":"2026-10-15T06:56:26.079421Z","steps":["trace[1760983525] 'read index received'  (duration: 36.471564ms)","trace[1760983525] 'applied index is now lower than readState.Index'  (duration: 119.526776ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T06:56:26.079685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.253756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-15T06:56:26.079791Z","caller":"traceutil/trace.go:171","msg":"trace[471291075] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11971; }","duration":"156.40577ms","start":"2026-10-15T06:56:25.923365Z","end":"2026-10-15T06:56:26.07977Z","steps":["trace[471291075] 'agreement among raft nodes before linearized reading'  (duration: 156.214145ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T06:56:50.177886Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9263}
{"level":"info","ts":"2026-10-15T06:56:50.266823Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9263,"took":"86.631183ms","hash":444790728,"current-db-size-bytes":60395520,"current-db-size":"60 MB","current-db-size-in-use-bytes":27865088,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-15T06:56:50.267082Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":444790728,"revision":9263,"compact-revision":6511}
{"level":"info","ts":"2026-10-15T07:01:50.184657Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12180}
{"level":"info","ts":"2026-10-15T07:01:50.285727Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12180,"took":"98.697848ms","hash":1146750262,"current-db-size-bytes":60395520,"current-db-size":"60 MB","current-db-size-in-use-bytes":25714688,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-10-15T07:01:50.2858Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1146750262,"revision":12180,"compact-revision":9263}
{"level":"info","ts":"2026-10-15T07:02:17.485904Z","caller":"traceutil/trace.go:171","msg":"trace[1092748412] transaction","detail":"{read_only:false; response_revision:14845; number_of_response:1; }","duration":"145.290545ms","start":"2026-10-15T07:02:17.340582Z","end":"2026-10-15T07:02:17.485873Z","steps":["trace[1092748412] 'process raft request'  (duration: 144.72743ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:02:52.066361Z","caller":"traceutil/trace.go:171","msg":"trace[485150360] transaction","detail":"{read_only:false; number_of_response:0; response_revision:15090; }","duration":"130.259266ms","start":"2026-10-15T07:02:51.936075Z","end":"2026-10-15T07:02:52.066334Z","steps":["trace[485150360] 'process raft request'  (duration: 130.160893ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:02:52.110285Z","caller":"traceutil/trace.go:171","msg":"trace[1885112060] transaction","detail":"{read_only:false; response_revision:15091; number_of_response:1; }","duration":"172.469062ms","start":"2026-10-15T07:02:51.9378Z","end":"2026-10-15T07:02:52.110269Z","steps":["trace[1885112060] 'process raft request'  (duration: 172.279627ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:02:52.11049Z","caller":"traceutil/trace.go:171","msg":"trace[14701710] transaction","detail":"{read_only:false; response_revision:15092; number_of_response:1; }","duration":"171.313273ms","start":"2026-10-15T07:02:51.939165Z","end":"2026-10-15T07:02:52.110478Z","steps":["trace[14701710] 'process raft request'  (duration: 171.065576ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:02:52.110513Z","caller":"traceutil/trace.go:171","msg":"trace[1301118728] linearizableReadLoop","detail":"{readStateIndex:15796; appliedIndex:15793; }","duration":"146.399364ms","start":"2026-10-15T07:02:51.96407Z","end":"2026-10-15T07:02:52.110469Z","steps":["trace[1301118728] 'read index received'  (duration: 102.151095ms)","trace[1301118728] 'applied index is now lower than readState.Index'  (duration: 44.245169ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T07:02:52.110736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.639801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-m4th8\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-10-15T07:02:52.110786Z","caller":"traceutil/trace.go:171","msg":"trace[127838163] range","detail":"{range_begin:/registry/pods/openstack/keepalived-m4th8; range_end:; response_count:1; response_revision:15092; }","duration":"146.758904ms","start":"2026-10-15T07:02:51.964016Z","end":"2026-10-15T07:02:52.110775Z","steps":["trace[127838163] 'agreement among raft nodes before linearized reading'  (duration: 146.539729ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:03:00.002082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.991465ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11193311212728935747 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:15071 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-15T07:03:00.002215Z","caller":"traceutil/trace.go:171","msg":"trace[1983757509] transaction","detail":"{read_only:false; response_revision:15148; number_of_response:1; }","duration":"369.661377ms","start":"2026-10-15T07:02:59.632517Z","end":"2026-10-15T07:03:00.002178Z","steps":["trace[1983757509] 'process raft request'  (duration: 263.480807ms)","trace[1983757509] 'compare'  (duration: 105.482882ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T07:03:00.002284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:02:59.63248Z","time spent":"369.767799ms","remote":"127.0.0.1:41924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:15071 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-10-15T07:04:19.067894Z","caller":"traceutil/trace.go:171","msg":"trace[80443439] transaction","detail":"{read_only:false; response_revision:16336; number_of_response:1; }","duration":"110.07392ms","start":"2026-10-15T07:04:18.957766Z","end":"2026-10-15T07:04:19.06784Z","steps":["trace[80443439] 'process raft request'  (duration: 86.919569ms)","trace[80443439] 'compare'  (duration: 22.877244ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:04:21.5937Z","caller":"traceutil/trace.go:171","msg":"trace[1290636836] transaction","detail":"{read_only:false; response_revision:16353; number_of_response:1; }","duration":"229.124017ms","start":"2026-10-15T07:04:21.364535Z","end":"2026-10-15T07:04:21.593659Z","steps":["trace[1290636836] 'process raft request'  (duration: 228.966363ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:21.594028Z","caller":"traceutil/trace.go:171","msg":"trace[363188167] linearizableReadLoop","detail":"{readStateIndex:17105; appliedIndex:17105; }","duration":"124.005523ms","start":"2026-10-15T07:04:21.469986Z","end":"2026-10-15T07:04:21.593992Z","steps":["trace[363188167] 'read index received'  (duration: 123.994243ms)","trace[363188167] 'applied index is now lower than readState.Index'  (duration: 9.22µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T07:04:21.594162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.162128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-15T07:04:21.594214Z","caller":"traceutil/trace.go:171","msg":"trace[2129819672] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16353; }","duration":"124.264051ms","start":"2026-10-15T07:04:21.469937Z","end":"2026-10-15T07:04:21.594201Z","steps":["trace[2129819672] 'agreement among raft nodes before linearized reading'  (duration: 124.167268ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:21.594281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.688135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"warn","ts":"2026-10-15T07:04:21.594286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.005677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5520"}
{"level":"info","ts":"2026-10-15T07:04:21.594306Z","caller":"traceutil/trace.go:171","msg":"trace[47485722] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16353; }","duration":"123.760087ms","start":"2026-10-15T07:04:21.470539Z","end":"2026-10-15T07:04:21.5943Z","steps":["trace[47485722] 'agreement among raft nodes before linearized reading'  (duration: 123.595163ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:21.594326Z","caller":"traceutil/trace.go:171","msg":"trace[838030476] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16353; }","duration":"118.060758ms","start":"2026-10-15T07:04:21.47625Z","end":"2026-10-15T07:04:21.594311Z","steps":["trace[838030476] 'agreement among raft nodes before linearized reading'  (duration: 117.907534ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:21.758826Z","caller":"traceutil/trace.go:171","msg":"trace[1266555269] linearizableReadLoop","detail":"{readStateIndex:17106; appliedIndex:17105; }","duration":"143.009828ms","start":"2026-10-15T07:04:21.61579Z","end":"2026-10-15T07:04:21.758799Z","steps":["trace[1266555269] 'read index received'  (duration: 102.929925ms)","trace[1266555269] 'applied index is now lower than readState.Index'  (duration: 40.078583ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:04:21.758984Z","caller":"traceutil/trace.go:171","msg":"trace[1715175011] transaction","detail":"{read_only:false; response_revision:16354; number_of_response:1; }","duration":"157.587326ms","start":"2026-10-15T07:04:21.601349Z","end":"2026-10-15T07:04:21.758937Z","steps":["trace[1715175011] 'process raft request'  (duration: 117.444802ms)","trace[1715175011] 'compare'  (duration: 39.767974ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T07:04:21.759109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.280314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-10-15T07:04:21.759261Z","caller":"traceutil/trace.go:171","msg":"trace[522856861] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16354; }","duration":"143.508801ms","start":"2026-10-15T07:04:21.615735Z","end":"2026-10-15T07:04:21.759244Z","steps":["trace[522856861] 'agreement among raft nodes before linearized reading'  (duration: 143.172482ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:23.27953Z","caller":"traceutil/trace.go:171","msg":"trace[721716156] linearizableReadLoop","detail":"{readStateIndex:17111; appliedIndex:17110; }","duration":"418.757067ms","start":"2026-10-15T07:04:22.860748Z","end":"2026-10-15T07:04:23.279505Z","steps":["trace[721716156] 'read index received'  (duration: 418.48745ms)","trace[721716156] 'applied index is now lower than readState.Index'  (duration: 268.637µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T07:04:23.279705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.502868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-15T07:04:23.279749Z","caller":"traceutil/trace.go:171","msg":"trace[54038135] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:16359; }","duration":"356.577561ms","start":"2026-10-15T07:04:22.923161Z","end":"2026-10-15T07:04:23.279739Z","steps":["trace[54038135] 'agreement among raft nodes before linearized reading'  (duration: 356.490848ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:23.279779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:22.923153Z","time spent":"356.619131ms","remote":"127.0.0.1:41654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-10-15T07:04:23.279626Z","caller":"traceutil/trace.go:171","msg":"trace[1861129867] transaction","detail":"{read_only:false; response_revision:16359; number_of_response:1; }","duration":"423.213612ms","start":"2026-10-15T07:04:22.856374Z","end":"2026-10-15T07:04:23.279588Z","steps":["trace[1861129867] 'process raft request'  (duration: 422.944835ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:23.279846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.317587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-10-15T07:04:23.279884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.220151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-15T07:04:23.279972Z","caller":"traceutil/trace.go:171","msg":"trace[493431962] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16359; }","duration":"321.349914ms","start":"2026-10-15T07:04:22.958606Z","end":"2026-10-15T07:04:23.279956Z","steps":["trace[493431962] 'agreement among raft nodes before linearized reading'  (duration: 321.233251ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:23.280021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:22.958578Z","time spent":"321.433406ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" "}
{"level":"warn","ts":"2026-10-15T07:04:23.280072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.746531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:525"}
{"level":"warn","ts":"2026-10-15T07:04:23.280088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:22.85634Z","time spent":"423.54376ms","remote":"127.0.0.1:41924","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:16347 > 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-10-15T07:04:23.280138Z","caller":"traceutil/trace.go:171","msg":"trace[328072188] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:16359; }","duration":"167.856044ms","start":"2026-10-15T07:04:23.112273Z","end":"2026-10-15T07:04:23.280129Z","steps":["trace[328072188] 'agreement among raft nodes before linearized reading'  (duration: 167.72503ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:23.280098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.28545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5520"}
{"level":"info","ts":"2026-10-15T07:04:23.280236Z","caller":"traceutil/trace.go:171","msg":"trace[524858564] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16359; }","duration":"419.496146ms","start":"2026-10-15T07:04:22.860712Z","end":"2026-10-15T07:04:23.280208Z","steps":["trace[524858564] 'agreement among raft nodes before linearized reading'  (duration: 418.922981ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:23.280277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.823726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5520"}
{"level":"info","ts":"2026-10-15T07:04:23.279973Z","caller":"traceutil/trace.go:171","msg":"trace[99894358] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16359; }","duration":"295.440691ms","start":"2026-10-15T07:04:22.984466Z","end":"2026-10-15T07:04:23.279907Z","steps":["trace[99894358] 'agreement among raft nodes before linearized reading'  (duration: 295.218565ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:23.280309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:22.860694Z","time spent":"419.597028ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5543,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"warn","ts":"2026-10-15T07:04:23.280333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.239651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-15T07:04:23.280343Z","caller":"traceutil/trace.go:171","msg":"trace[1567155794] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16359; }","duration":"321.902188ms","start":"2026-10-15T07:04:22.95842Z","end":"2026-10-15T07:04:23.280322Z","steps":["trace[1567155794] 'agreement among raft nodes before linearized reading'  (duration: 321.528848ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:23.280369Z","caller":"traceutil/trace.go:171","msg":"trace[2055441351] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16359; }","duration":"321.290772ms","start":"2026-10-15T07:04:22.959064Z","end":"2026-10-15T07:04:23.280355Z","steps":["trace[2055441351] 'agreement among raft nodes before linearized reading'  (duration: 321.249801ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:23.280167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.701428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-10-15T07:04:23.280397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:22.958414Z","time spent":"321.96994ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5543,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"warn","ts":"2026-10-15T07:04:23.280405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:22.959052Z","time spent":"321.344283ms","remote":"127.0.0.1:41896","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-10-15T07:04:23.280428Z","caller":"traceutil/trace.go:171","msg":"trace[383038342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:16359; }","duration":"322.997696ms","start":"2026-10-15T07:04:22.957413Z","end":"2026-10-15T07:04:23.280411Z","steps":["trace[383038342] 'agreement among raft nodes before linearized reading'  (duration: 322.653247ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:23.280298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.58125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-15T07:04:23.280474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:22.957396Z","time spent":"323.062858ms","remote":"127.0.0.1:41924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-10-15T07:04:23.280501Z","caller":"traceutil/trace.go:171","msg":"trace[1405294630] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16359; }","duration":"321.775255ms","start":"2026-10-15T07:04:22.958709Z","end":"2026-10-15T07:04:23.280484Z","steps":["trace[1405294630] 'agreement among raft nodes before linearized reading'  (duration: 321.566869ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:23.28055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:22.958654Z","time spent":"321.880997ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/nova-ks-user\" "}
{"level":"info","ts":"2026-10-15T07:04:23.969741Z","caller":"traceutil/trace.go:171","msg":"trace[1164557133] transaction","detail":"{read_only:false; response_revision:16369; number_of_response:1; }","duration":"131.855428ms","start":"2026-10-15T07:04:23.837861Z","end":"2026-10-15T07:04:23.969717Z","steps":["trace[1164557133] 'process raft request'  (duration: 131.758405ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:23.96988Z","caller":"traceutil/trace.go:171","msg":"trace[209837823] linearizableReadLoop","detail":"{readStateIndex:17123; appliedIndex:17120; }","duration":"115.664747ms","start":"2026-10-15T07:04:23.854196Z","end":"2026-10-15T07:04:23.96986Z","steps":["trace[209837823] 'read index received'  (duration: 84.808554ms)","trace[209837823] 'applied index is now lower than readState.Index'  (duration: 30.853893ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:04:23.970029Z","caller":"traceutil/trace.go:171","msg":"trace[246030390] transaction","detail":"{read_only:false; response_revision:16370; number_of_response:1; }","duration":"130.643947ms","start":"2026-10-15T07:04:23.83937Z","end":"2026-10-15T07:04:23.970014Z","steps":["trace[246030390] 'process raft request'  (duration: 130.307148ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:23.970323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.102308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-10-15T07:04:23.970387Z","caller":"traceutil/trace.go:171","msg":"trace[773784288] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:16370; }","duration":"116.218021ms","start":"2026-10-15T07:04:23.854154Z","end":"2026-10-15T07:04:23.970372Z","steps":["trace[773784288] 'agreement among raft nodes before linearized reading'  (duration: 116.016966ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:23.969765Z","caller":"traceutil/trace.go:171","msg":"trace[295675395] transaction","detail":"{read_only:false; response_revision:16368; number_of_response:1; }","duration":"132.025132ms","start":"2026-10-15T07:04:23.83767Z","end":"2026-10-15T07:04:23.969695Z","steps":["trace[295675395] 'process raft request'  (duration: 101.332684ms)","trace[295675395] 'compare'  (duration: 30.476703ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:04:24.739344Z","caller":"traceutil/trace.go:171","msg":"trace[1425398599] transaction","detail":"{read_only:false; response_revision:16374; number_of_response:1; }","duration":"111.280613ms","start":"2026-10-15T07:04:24.628018Z","end":"2026-10-15T07:04:24.739299Z","steps":["trace[1425398599] 'process raft request'  (duration: 111.074478ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:25.455214Z","caller":"traceutil/trace.go:171","msg":"trace[1739280335] transaction","detail":"{read_only:false; number_of_response:0; response_revision:16376; }","duration":"121.18349ms","start":"2026-10-15T07:04:25.333994Z","end":"2026-10-15T07:04:25.455177Z","steps":["trace[1739280335] 'process raft request'  (duration: 111.114329ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:25.455299Z","caller":"traceutil/trace.go:171","msg":"trace[385203460] transaction","detail":"{read_only:false; response_revision:16377; number_of_response:1; }","duration":"108.007758ms","start":"2026-10-15T07:04:25.347263Z","end":"2026-10-15T07:04:25.45527Z","steps":["trace[385203460] 'process raft request'  (duration: 107.893565ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:25.455337Z","caller":"traceutil/trace.go:171","msg":"trace[1670231864] linearizableReadLoop","detail":"{readStateIndex:17130; appliedIndex:17129; }","duration":"112.781932ms","start":"2026-10-15T07:04:25.342534Z","end":"2026-10-15T07:04:25.455316Z","steps":["trace[1670231864] 'read index received'  (duration: 102.596208ms)","trace[1670231864] 'applied index is now lower than readState.Index'  (duration: 10.179214ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T07:04:25.455498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.34291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-15T07:04:25.455555Z","caller":"traceutil/trace.go:171","msg":"trace[2103075534] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16377; }","duration":"167.433421ms","start":"2026-10-15T07:04:25.288106Z","end":"2026-10-15T07:04:25.45554Z","steps":["trace[2103075534] 'agreement among raft nodes before linearized reading'  (duration: 167.243627ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:25.455606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.599426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5520"}
{"level":"info","ts":"2026-10-15T07:04:25.45567Z","caller":"traceutil/trace.go:171","msg":"trace[701275742] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16377; }","duration":"167.739899ms","start":"2026-10-15T07:04:25.287913Z","end":"2026-10-15T07:04:25.455653Z","steps":["trace[701275742] 'agreement among raft nodes before linearized reading'  (duration: 167.503753ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:25.455775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.592763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:525"}
{"level":"info","ts":"2026-10-15T07:04:25.455888Z","caller":"traceutil/trace.go:171","msg":"trace[768096733] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:16377; }","duration":"123.782908ms","start":"2026-10-15T07:04:25.332085Z","end":"2026-10-15T07:04:25.455868Z","steps":["trace[768096733] 'agreement among raft nodes before linearized reading'  (duration: 123.330116ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:25.455948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.24747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5520"}
{"level":"info","ts":"2026-10-15T07:04:25.455984Z","caller":"traceutil/trace.go:171","msg":"trace[1141122687] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16377; }","duration":"169.299922ms","start":"2026-10-15T07:04:25.286675Z","end":"2026-10-15T07:04:25.455975Z","steps":["trace[1141122687] 'agreement among raft nodes before linearized reading'  (duration: 169.198938ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:25.456072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.875631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-15T07:04:25.456084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.518048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-m4th8\" ","response":"range_response_count:1 size:6524"}
{"level":"warn","ts":"2026-10-15T07:04:25.456129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.27783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-15T07:04:25.456135Z","caller":"traceutil/trace.go:171","msg":"trace[1518585960] range","detail":"{range_begin:/registry/pods/openstack/keepalived-m4th8; range_end:; response_count:1; response_revision:16377; }","duration":"109.595659ms","start":"2026-10-15T07:04:25.346525Z","end":"2026-10-15T07:04:25.456121Z","steps":["trace[1518585960] 'agreement among raft nodes before linearized reading'  (duration: 109.452316ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:25.456157Z","caller":"traceutil/trace.go:171","msg":"trace[1687987971] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16377; }","duration":"169.352033ms","start":"2026-10-15T07:04:25.286798Z","end":"2026-10-15T07:04:25.45615Z","steps":["trace[1687987971] 'agreement among raft nodes before linearized reading'  (duration: 169.315562ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:25.456218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.80257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-10-15T07:04:25.455844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.526847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-10-15T07:04:25.456293Z","caller":"traceutil/trace.go:171","msg":"trace[675492415] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:16377; }","duration":"123.897161ms","start":"2026-10-15T07:04:25.332382Z","end":"2026-10-15T07:04:25.456279Z","steps":["trace[675492415] 'agreement among raft nodes before linearized reading'  (duration: 123.694116ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:25.456099Z","caller":"traceutil/trace.go:171","msg":"trace[482022108] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16377; }","duration":"169.013975ms","start":"2026-10-15T07:04:25.287078Z","end":"2026-10-15T07:04:25.456092Z","steps":["trace[482022108] 'agreement among raft nodes before linearized reading'  (duration: 168.975274ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:25.456294Z","caller":"traceutil/trace.go:171","msg":"trace[1782551644] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16377; }","duration":"125.012431ms","start":"2026-10-15T07:04:25.331271Z","end":"2026-10-15T07:04:25.456283Z","steps":["trace[1782551644] 'agreement among raft nodes before linearized reading'  (duration: 124.458755ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:26.457229Z","caller":"traceutil/trace.go:171","msg":"trace[878587351] transaction","detail":"{read_only:false; response_revision:16389; number_of_response:1; }","duration":"104.462515ms","start":"2026-10-15T07:04:26.352408Z","end":"2026-10-15T07:04:26.456871Z","steps":["trace[878587351] 'process raft request'  (duration: 104.274991ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:27.678951Z","caller":"traceutil/trace.go:171","msg":"trace[240178267] transaction","detail":"{read_only:false; response_revision:16394; number_of_response:1; }","duration":"102.969697ms","start":"2026-10-15T07:04:27.575904Z","end":"2026-10-15T07:04:27.678874Z","steps":["trace[240178267] 'process raft request'  (duration: 59.652551ms)","trace[240178267] 'compare'  (duration: 43.107251ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:04:27.679239Z","caller":"traceutil/trace.go:171","msg":"trace[1277624036] transaction","detail":"{read_only:false; response_revision:16395; number_of_response:1; }","duration":"103.245324ms","start":"2026-10-15T07:04:27.575973Z","end":"2026-10-15T07:04:27.679218Z","steps":["trace[1277624036] 'process raft request'  (duration: 102.853974ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:28.300679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.304913ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11193311212728939417 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:16384 > 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\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-15T07:04:28.300866Z","caller":"traceutil/trace.go:171","msg":"trace[1993193290] linearizableReadLoop","detail":"{readStateIndex:17155; appliedIndex:17153; }","duration":"198.770318ms","start":"2026-10-15T07:04:28.102078Z","end":"2026-10-15T07:04:28.300848Z","steps":["trace[1993193290] 'read index received'  (duration: 24.644261ms)","trace[1993193290] 'applied index is now lower than readState.Index'  (duration: 174.124286ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T07:04:28.301155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.129403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-qxx2t\" ","response":"range_response_count:1 size:20630"}
{"level":"info","ts":"2026-10-15T07:04:28.301338Z","caller":"traceutil/trace.go:171","msg":"trace[1266124320] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-qxx2t; range_end:; response_count:1; response_revision:16401; }","duration":"135.357179ms","start":"2026-10-15T07:04:28.165967Z","end":"2026-10-15T07:04:28.301324Z","steps":["trace[1266124320] 'agreement among raft nodes before linearized reading'  (duration: 135.048041ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:28.301344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.26514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:662"}
{"level":"info","ts":"2026-10-15T07:04:28.301547Z","caller":"traceutil/trace.go:171","msg":"trace[1803725183] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:16401; }","duration":"199.516426ms","start":"2026-10-15T07:04:28.102014Z","end":"2026-10-15T07:04:28.30153Z","steps":["trace[1803725183] 'agreement among raft nodes before linearized reading'  (duration: 198.962692ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:28.301121Z","caller":"traceutil/trace.go:171","msg":"trace[900558985] transaction","detail":"{read_only:false; response_revision:16401; number_of_response:1; }","duration":"236.21985ms","start":"2026-10-15T07:04:28.064743Z","end":"2026-10-15T07:04:28.300963Z","steps":["trace[900558985] 'process raft request'  (duration: 89.539708ms)","trace[900558985] 'compare'  (duration: 146.1952ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:04:29.733975Z","caller":"traceutil/trace.go:171","msg":"trace[719683912] linearizableReadLoop","detail":"{readStateIndex:17160; appliedIndex:17159; }","duration":"132.623638ms","start":"2026-10-15T07:04:29.601299Z","end":"2026-10-15T07:04:29.733923Z","steps":["trace[719683912] 'read index received'  (duration: 132.455613ms)","trace[719683912] 'applied index is now lower than readState.Index'  (duration: 166.715µs)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:04:29.734033Z","caller":"traceutil/trace.go:171","msg":"trace[1925876575] transaction","detail":"{read_only:false; response_revision:16405; number_of_response:1; }","duration":"153.793598ms","start":"2026-10-15T07:04:29.580209Z","end":"2026-10-15T07:04:29.734003Z","steps":["trace[1925876575] 'process raft request'  (duration: 153.523231ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:29.734234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.682471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:528"}
{"level":"info","ts":"2026-10-15T07:04:29.734277Z","caller":"traceutil/trace.go:171","msg":"trace[944097594] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:16405; }","duration":"109.744672ms","start":"2026-10-15T07:04:29.62452Z","end":"2026-10-15T07:04:29.734264Z","steps":["trace[944097594] 'agreement among raft nodes before linearized reading'  (duration: 109.581828ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:29.734362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.039829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-m4th8\" ","response":"range_response_count:1 size:6525"}
{"level":"info","ts":"2026-10-15T07:04:29.734478Z","caller":"traceutil/trace.go:171","msg":"trace[285525021] range","detail":"{range_begin:/registry/pods/openstack/keepalived-m4th8; range_end:; response_count:1; response_revision:16405; }","duration":"133.212663ms","start":"2026-10-15T07:04:29.601238Z","end":"2026-10-15T07:04:29.73445Z","steps":["trace[285525021] 'agreement among raft nodes before linearized reading'  (duration: 132.844744ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:29.892193Z","caller":"traceutil/trace.go:171","msg":"trace[2050871398] transaction","detail":"{read_only:false; response_revision:16409; number_of_response:1; }","duration":"100.164994ms","start":"2026-10-15T07:04:29.791988Z","end":"2026-10-15T07:04:29.892153Z","steps":["trace[2050871398] 'process raft request'  (duration: 33.619844ms)","trace[2050871398] 'compare'  (duration: 66.354776ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:04:31.937468Z","caller":"traceutil/trace.go:171","msg":"trace[1185894966] transaction","detail":"{read_only:false; response_revision:16422; number_of_response:1; }","duration":"136.047327ms","start":"2026-10-15T07:04:31.801361Z","end":"2026-10-15T07:04:31.937408Z","steps":["trace[1185894966] 'process raft request'  (duration: 135.78526ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:33.397257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.151019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-15T07:04:33.397338Z","caller":"traceutil/trace.go:171","msg":"trace[1452009199] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:16430; }","duration":"216.289852ms","start":"2026-10-15T07:04:33.181026Z","end":"2026-10-15T07:04:33.397316Z","steps":["trace[1452009199] 'count revisions from in-memory index tree'  (duration: 216.011615ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:33.397381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.462138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:669"}
{"level":"info","ts":"2026-10-15T07:04:33.397523Z","caller":"traceutil/trace.go:171","msg":"trace[1104000601] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16430; }","duration":"453.692254ms","start":"2026-10-15T07:04:32.943796Z","end":"2026-10-15T07:04:33.397488Z","steps":["trace[1104000601] 'range keys from in-memory index tree'  (duration: 453.215992ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:33.39759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:32.943779Z","time spent":"453.791977ms","remote":"127.0.0.1:41818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":692,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "}
{"level":"warn","ts":"2026-10-15T07:04:33.397701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.146328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-15T07:04:33.397756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.531429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-15T07:04:33.397799Z","caller":"traceutil/trace.go:171","msg":"trace[1309713498] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16430; }","duration":"553.288382ms","start":"2026-10-15T07:04:32.844485Z","end":"2026-10-15T07:04:33.397774Z","steps":["trace[1309713498] 'range keys from in-memory index tree'  (duration: 553.027996ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:33.397827Z","caller":"traceutil/trace.go:171","msg":"trace[1716960101] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16430; }","duration":"553.625342ms","start":"2026-10-15T07:04:32.844176Z","end":"2026-10-15T07:04:33.397801Z","steps":["trace[1716960101] 'range keys from in-memory index tree'  (duration: 553.454827ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:33.397838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.490508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5522"}
{"level":"warn","ts":"2026-10-15T07:04:33.397846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:32.844463Z","time spent":"553.373336ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "}
{"level":"warn","ts":"2026-10-15T07:04:33.397859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.302634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-15T07:04:33.397878Z","caller":"traceutil/trace.go:171","msg":"trace[1201704479] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16430; }","duration":"553.5599ms","start":"2026-10-15T07:04:32.844306Z","end":"2026-10-15T07:04:33.397866Z","steps":["trace[1201704479] 'range keys from in-memory index tree'  (duration: 553.311943ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:33.39788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:32.844157Z","time spent":"553.707304ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/nova-ks-user\" "}
{"level":"warn","ts":"2026-10-15T07:04:33.397908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:32.844288Z","time spent":"553.612701ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5545,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "}
{"level":"info","ts":"2026-10-15T07:04:33.397912Z","caller":"traceutil/trace.go:171","msg":"trace[1047042454] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16430; }","duration":"553.377796ms","start":"2026-10-15T07:04:32.844514Z","end":"2026-10-15T07:04:33.397892Z","steps":["trace[1047042454] 'range keys from in-memory index tree'  (duration: 553.238022ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:33.397989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:32.844495Z","time spent":"553.485038ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" "}
{"level":"warn","ts":"2026-10-15T07:04:33.397574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.647613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-15T07:04:33.398032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.613468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-15T07:04:33.398052Z","caller":"traceutil/trace.go:171","msg":"trace[1203363166] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16430; }","duration":"454.163317ms","start":"2026-10-15T07:04:32.943869Z","end":"2026-10-15T07:04:33.398033Z","steps":["trace[1203363166] 'range keys from in-memory index tree'  (duration: 453.563591ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:33.398072Z","caller":"traceutil/trace.go:171","msg":"trace[631555576] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:16430; }","duration":"474.675399ms","start":"2026-10-15T07:04:32.923386Z","end":"2026-10-15T07:04:33.398062Z","steps":["trace[631555576] 'range keys from in-memory index tree'  (duration: 474.518746ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:33.398105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:32.943859Z","time spent":"454.231019ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "}
{"level":"warn","ts":"2026-10-15T07:04:33.398124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:32.923373Z","time spent":"474.735412ms","remote":"127.0.0.1:41646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-10-15T07:04:33.39832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.090717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-m4qnd\" ","response":"range_response_count:1 size:9785"}
{"level":"info","ts":"2026-10-15T07:04:33.398364Z","caller":"traceutil/trace.go:171","msg":"trace[2041393776] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-m4qnd; range_end:; response_count:1; response_revision:16430; }","duration":"536.152438ms","start":"2026-10-15T07:04:32.862196Z","end":"2026-10-15T07:04:33.398349Z","steps":["trace[2041393776] 'range keys from in-memory index tree'  (duration: 535.964774ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:33.398402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:32.862185Z","time spent":"536.205739ms","remote":"127.0.0.1:41838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9808,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-m4qnd\" "}
{"level":"info","ts":"2026-10-15T07:04:34.197598Z","caller":"traceutil/trace.go:171","msg":"trace[872619901] linearizableReadLoop","detail":"{readStateIndex:17193; appliedIndex:17192; }","duration":"123.4752ms","start":"2026-10-15T07:04:34.07409Z","end":"2026-10-15T07:04:34.197566Z","steps":["trace[872619901] 'read index received'  (duration: 123.251734ms)","trace[872619901] 'applied index is now lower than readState.Index'  (duration: 222.126µs)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:04:34.197736Z","caller":"traceutil/trace.go:171","msg":"trace[2066285652] transaction","detail":"{read_only:false; response_revision:16436; number_of_response:1; }","duration":"178.377167ms","start":"2026-10-15T07:04:34.019318Z","end":"2026-10-15T07:04:34.197695Z","steps":["trace[2066285652] 'process raft request'  (duration: 178.050959ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:34.197812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.706065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-15T07:04:34.197861Z","caller":"traceutil/trace.go:171","msg":"trace[694312913] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16436; }","duration":"123.776717ms","start":"2026-10-15T07:04:34.07407Z","end":"2026-10-15T07:04:34.197847Z","steps":["trace[694312913] 'agreement among raft nodes before linearized reading'  (duration: 123.672194ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:34.197912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.412988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-15T07:04:34.198018Z","caller":"traceutil/trace.go:171","msg":"trace[2121621032] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:16436; }","duration":"123.565892ms","start":"2026-10-15T07:04:34.074431Z","end":"2026-10-15T07:04:34.197997Z","steps":["trace[2121621032] 'agreement among raft nodes before linearized reading'  (duration: 123.379237ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:34.198154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.228437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5522"}
{"level":"warn","ts":"2026-10-15T07:04:34.198259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.792222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:669"}
{"level":"info","ts":"2026-10-15T07:04:34.198269Z","caller":"traceutil/trace.go:171","msg":"trace[738244242] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16436; }","duration":"122.38598ms","start":"2026-10-15T07:04:34.075855Z","end":"2026-10-15T07:04:34.198241Z","steps":["trace[738244242] 'agreement among raft nodes before linearized reading'  (duration: 122.023731ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:34.198311Z","caller":"traceutil/trace.go:171","msg":"trace[1086673566] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16436; }","duration":"122.893685ms","start":"2026-10-15T07:04:34.075404Z","end":"2026-10-15T07:04:34.198297Z","steps":["trace[1086673566] 'agreement among raft nodes before linearized reading'  (duration: 122.694419ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:34.198699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.287375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:683"}
{"level":"info","ts":"2026-10-15T07:04:34.198814Z","caller":"traceutil/trace.go:171","msg":"trace[1510167243] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:16436; }","duration":"123.436788ms","start":"2026-10-15T07:04:34.075349Z","end":"2026-10-15T07:04:34.198785Z","steps":["trace[1510167243] 'agreement among raft nodes before linearized reading'  (duration: 122.893124ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:34.316781Z","caller":"traceutil/trace.go:171","msg":"trace[706261511] transaction","detail":"{read_only:false; response_revision:16437; number_of_response:1; }","duration":"113.740428ms","start":"2026-10-15T07:04:34.203007Z","end":"2026-10-15T07:04:34.316747Z","steps":["trace[706261511] 'process raft request'  (duration: 29.21753ms)","trace[706261511] 'compare'  (duration: 84.383743ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:04:34.367332Z","caller":"traceutil/trace.go:171","msg":"trace[176719636] transaction","detail":"{read_only:false; response_revision:16438; number_of_response:1; }","duration":"160.978725ms","start":"2026-10-15T07:04:34.206306Z","end":"2026-10-15T07:04:34.367285Z","steps":["trace[176719636] 'process raft request'  (duration: 160.77108ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:34.95933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.184916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-fr4dm\" ","response":"range_response_count:1 size:22090"}
{"level":"warn","ts":"2026-10-15T07:04:34.959385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.78236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:662"}
{"level":"info","ts":"2026-10-15T07:04:34.959426Z","caller":"traceutil/trace.go:171","msg":"trace[1725014951] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-fr4dm; range_end:; response_count:1; response_revision:16439; }","duration":"397.3467ms","start":"2026-10-15T07:04:34.562061Z","end":"2026-10-15T07:04:34.959407Z","steps":["trace[1725014951] 'range keys from in-memory index tree'  (duration: 396.94283ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:34.959459Z","caller":"traceutil/trace.go:171","msg":"trace[1082981306] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:16439; }","duration":"372.915734ms","start":"2026-10-15T07:04:34.586522Z","end":"2026-10-15T07:04:34.959438Z","steps":["trace[1082981306] 'range keys from in-memory index tree'  (duration: 372.525644ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:34.95947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:34.562009Z","time spent":"397.452462ms","remote":"127.0.0.1:41838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22113,"request content":"key:\"/registry/pods/openstack/nova-compute-default-fr4dm\" "}
{"level":"warn","ts":"2026-10-15T07:04:34.959503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:34.586497Z","time spent":"372.996546ms","remote":"127.0.0.1:41746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":1,"response size":685,"request content":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" "}
{"level":"warn","ts":"2026-10-15T07:04:34.959535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.585114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-fr4dm\" ","response":"range_response_count:1 size:22090"}
{"level":"info","ts":"2026-10-15T07:04:34.959619Z","caller":"traceutil/trace.go:171","msg":"trace[528846569] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-fr4dm; range_end:; response_count:1; response_revision:16439; }","duration":"395.686726ms","start":"2026-10-15T07:04:34.563911Z","end":"2026-10-15T07:04:34.959598Z","steps":["trace[528846569] 'range keys from in-memory index tree'  (duration: 395.353388ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:34.959657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:34.563879Z","time spent":"395.770318ms","remote":"127.0.0.1:41838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22113,"request content":"key:\"/registry/pods/openstack/nova-compute-default-fr4dm\" "}
{"level":"warn","ts":"2026-10-15T07:04:34.959589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.940151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-15T07:04:34.9598Z","caller":"traceutil/trace.go:171","msg":"trace[1400235635] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16439; }","duration":"349.340372ms","start":"2026-10-15T07:04:34.61043Z","end":"2026-10-15T07:04:34.95977Z","steps":["trace[1400235635] 'range keys from in-memory index tree'  (duration: 348.799728ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:34.959881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:04:34.610419Z","time spent":"349.447964ms","remote":"127.0.0.1:41896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "}
{"level":"warn","ts":"2026-10-15T07:04:34.960442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.922083ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11193311212728939619 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:16430 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-15T07:04:34.960514Z","caller":"traceutil/trace.go:171","msg":"trace[16932333] linearizableReadLoop","detail":"{readStateIndex:17197; appliedIndex:17196; }","duration":"249.922877ms","start":"2026-10-15T07:04:34.71058Z","end":"2026-10-15T07:04:34.960502Z","steps":["trace[16932333] 'read index received'  (duration: 113.780988ms)","trace[16932333] 'applied index is now lower than readState.Index'  (duration: 136.140659ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:04:34.960547Z","caller":"traceutil/trace.go:171","msg":"trace[1959734811] transaction","detail":"{read_only:false; response_revision:16440; number_of_response:1; }","duration":"250.681456ms","start":"2026-10-15T07:04:34.709838Z","end":"2026-10-15T07:04:34.96052Z","steps":["trace[1959734811] 'process raft request'  (duration: 114.604779ms)","trace[1959734811] 'compare'  (duration: 135.485382ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T07:04:34.960686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.105691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5522"}
{"level":"info","ts":"2026-10-15T07:04:34.960719Z","caller":"traceutil/trace.go:171","msg":"trace[25458470] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16440; }","duration":"250.170943ms","start":"2026-10-15T07:04:34.710538Z","end":"2026-10-15T07:04:34.960709Z","steps":["trace[25458470] 'agreement among raft nodes before linearized reading'  (duration: 250.04427ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:34.960722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.471269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:669"}
{"level":"info","ts":"2026-10-15T07:04:34.960779Z","caller":"traceutil/trace.go:171","msg":"trace[1628497194] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16440; }","duration":"178.562801ms","start":"2026-10-15T07:04:34.782202Z","end":"2026-10-15T07:04:34.960765Z","steps":["trace[1628497194] 'agreement among raft nodes before linearized reading'  (duration: 178.411437ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:35.149638Z","caller":"traceutil/trace.go:171","msg":"trace[794047373] linearizableReadLoop","detail":"{readStateIndex:17198; appliedIndex:17197; }","duration":"180.176804ms","start":"2026-10-15T07:04:34.969431Z","end":"2026-10-15T07:04:35.149607Z","steps":["trace[794047373] 'read index received'  (duration: 127.993907ms)","trace[794047373] 'applied index is now lower than readState.Index'  (duration: 52.181557ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:04:35.149695Z","caller":"traceutil/trace.go:171","msg":"trace[2057722361] transaction","detail":"{read_only:false; response_revision:16441; number_of_response:1; }","duration":"180.794781ms","start":"2026-10-15T07:04:34.968868Z","end":"2026-10-15T07:04:35.149663Z","steps":["trace[2057722361] 'process raft request'  (duration: 128.648355ms)","trace[2057722361] 'compare'  (duration: 51.93861ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T07:04:35.150634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.178949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:78 size:741800"}
{"level":"info","ts":"2026-10-15T07:04:35.1507Z","caller":"traceutil/trace.go:171","msg":"trace[1283472710] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:78; response_revision:16441; }","duration":"181.306823ms","start":"2026-10-15T07:04:34.969381Z","end":"2026-10-15T07:04:35.150688Z","steps":["trace[1283472710] 'agreement among raft nodes before linearized reading'  (duration: 180.373489ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:35.151507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.468761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:78 size:741800"}
{"level":"info","ts":"2026-10-15T07:04:35.151615Z","caller":"traceutil/trace.go:171","msg":"trace[220947517] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:78; response_revision:16441; }","duration":"180.664557ms","start":"2026-10-15T07:04:34.970928Z","end":"2026-10-15T07:04:35.151592Z","steps":["trace[220947517] 'agreement among raft nodes before linearized reading'  (duration: 179.075675ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:36.43588Z","caller":"traceutil/trace.go:171","msg":"trace[406110647] linearizableReadLoop","detail":"{readStateIndex:17207; appliedIndex:17206; }","duration":"114.24051ms","start":"2026-10-15T07:04:36.321615Z","end":"2026-10-15T07:04:36.435855Z","steps":["trace[406110647] 'read index received'  (duration: 114.035924ms)","trace[406110647] 'applied index is now lower than readState.Index'  (duration: 203.686µs)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:04:36.436022Z","caller":"traceutil/trace.go:171","msg":"trace[1847139971] transaction","detail":"{read_only:false; response_revision:16449; number_of_response:1; }","duration":"129.610959ms","start":"2026-10-15T07:04:36.306398Z","end":"2026-10-15T07:04:36.436009Z","steps":["trace[1847139971] 'process raft request'  (duration: 129.327181ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:36.436271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.63166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-10-15T07:04:36.43638Z","caller":"traceutil/trace.go:171","msg":"trace[561519691] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16449; }","duration":"114.812804ms","start":"2026-10-15T07:04:36.321541Z","end":"2026-10-15T07:04:36.436353Z","steps":["trace[561519691] 'agreement among raft nodes before linearized reading'  (duration: 114.512857ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:36.562184Z","caller":"traceutil/trace.go:171","msg":"trace[1763470180] transaction","detail":"{read_only:false; response_revision:16450; number_of_response:1; }","duration":"120.245846ms","start":"2026-10-15T07:04:36.441904Z","end":"2026-10-15T07:04:36.56215Z","steps":["trace[1763470180] 'process raft request'  (duration: 32.120375ms)","trace[1763470180] 'compare'  (duration: 87.971777ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:04:36.573713Z","caller":"traceutil/trace.go:171","msg":"trace[956119770] linearizableReadLoop","detail":"{readStateIndex:17209; appliedIndex:17207; }","duration":"108.365306ms","start":"2026-10-15T07:04:36.465314Z","end":"2026-10-15T07:04:36.57368Z","steps":["trace[956119770] 'read index received'  (duration: 8.704416ms)","trace[956119770] 'applied index is now lower than readState.Index'  (duration: 99.65925ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:04:36.573841Z","caller":"traceutil/trace.go:171","msg":"trace[559240461] transaction","detail":"{read_only:false; response_revision:16451; number_of_response:1; }","duration":"128.800039ms","start":"2026-10-15T07:04:36.445003Z","end":"2026-10-15T07:04:36.573803Z","steps":["trace[559240461] 'process raft request'  (duration: 128.415149ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:36.574068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.008446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-10-15T07:04:36.57412Z","caller":"traceutil/trace.go:171","msg":"trace[403316893] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:16451; }","duration":"106.133439ms","start":"2026-10-15T07:04:36.467974Z","end":"2026-10-15T07:04:36.574107Z","steps":["trace[403316893] 'agreement among raft nodes before linearized reading'  (duration: 105.891153ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:36.57411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.771937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11498"}
{"level":"info","ts":"2026-10-15T07:04:36.574186Z","caller":"traceutil/trace.go:171","msg":"trace[1840452212] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:16451; }","duration":"108.918581ms","start":"2026-10-15T07:04:36.465248Z","end":"2026-10-15T07:04:36.574167Z","steps":["trace[1840452212] 'agreement among raft nodes before linearized reading'  (duration: 108.610913ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:43.114345Z","caller":"traceutil/trace.go:171","msg":"trace[1162823725] transaction","detail":"{read_only:false; response_revision:16493; number_of_response:1; }","duration":"103.044419ms","start":"2026-10-15T07:04:43.011274Z","end":"2026-10-15T07:04:43.114318Z","steps":["trace[1162823725] 'process raft request'  (duration: 102.869335ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:43.225258Z","caller":"traceutil/trace.go:171","msg":"trace[495644562] transaction","detail":"{read_only:false; response_revision:16494; number_of_response:1; }","duration":"173.635234ms","start":"2026-10-15T07:04:43.051559Z","end":"2026-10-15T07:04:43.225195Z","steps":["trace[495644562] 'process raft request'  (duration: 164.232699ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:43.93383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.923648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.116\" ","response":"range_response_count:1 size:140"}
{"level":"info","ts":"2026-10-15T07:04:43.93395Z","caller":"traceutil/trace.go:171","msg":"trace[1274447666] range","detail":"{range_begin:/registry/masterleases/199.19.213.116; range_end:; response_count:1; response_revision:16497; }","duration":"145.090622ms","start":"2026-10-15T07:04:43.788815Z","end":"2026-10-15T07:04:43.933906Z","steps":["trace[1274447666] 'range keys from in-memory index tree'  (duration: 144.680561ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:44.07758Z","caller":"traceutil/trace.go:171","msg":"trace[2003295035] linearizableReadLoop","detail":"{readStateIndex:17258; appliedIndex:17257; }","duration":"137.494755ms","start":"2026-10-15T07:04:43.940029Z","end":"2026-10-15T07:04:44.077524Z","steps":["trace[2003295035] 'read index received'  (duration: 137.362311ms)","trace[2003295035] 'applied index is now lower than readState.Index'  (duration: 130.534µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T07:04:44.078934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.822528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:78 size:741800"}
{"level":"info","ts":"2026-10-15T07:04:44.079087Z","caller":"traceutil/trace.go:171","msg":"trace[1144680608] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:78; response_revision:16497; }","duration":"139.123846ms","start":"2026-10-15T07:04:43.939936Z","end":"2026-10-15T07:04:44.07906Z","steps":["trace[1144680608] 'agreement among raft nodes before linearized reading'  (duration: 137.803172ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:44.107297Z","caller":"traceutil/trace.go:171","msg":"trace[1878373367] transaction","detail":"{read_only:false; response_revision:16498; number_of_response:1; }","duration":"166.902348ms","start":"2026-10-15T07:04:43.940365Z","end":"2026-10-15T07:04:44.107267Z","steps":["trace[1878373367] 'process raft request'  (duration: 166.383105ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:04:44.107584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.192411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-10-15T07:04:44.107659Z","caller":"traceutil/trace.go:171","msg":"trace[1881124074] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:16498; }","duration":"101.313355ms","start":"2026-10-15T07:04:44.006329Z","end":"2026-10-15T07:04:44.107643Z","steps":["trace[1881124074] 'agreement among raft nodes before linearized reading'  (duration: 100.982835ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:44.313621Z","caller":"traceutil/trace.go:171","msg":"trace[827669984] transaction","detail":"{read_only:false; response_revision:16499; number_of_response:1; }","duration":"232.161335ms","start":"2026-10-15T07:04:44.0814Z","end":"2026-10-15T07:04:44.313561Z","steps":["trace[827669984] 'process raft request'  (duration: 150.065992ms)","trace[827669984] 'compare'  (duration: 81.821636ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:04:44.313726Z","caller":"traceutil/trace.go:171","msg":"trace[1515774655] transaction","detail":"{read_only:false; response_revision:16501; number_of_response:1; }","duration":"200.275556ms","start":"2026-10-15T07:04:44.113431Z","end":"2026-10-15T07:04:44.313707Z","steps":["trace[1515774655] 'process raft request'  (duration: 200.209984ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:44.313812Z","caller":"traceutil/trace.go:171","msg":"trace[1834179262] transaction","detail":"{read_only:false; response_revision:16500; number_of_response:1; }","duration":"200.943324ms","start":"2026-10-15T07:04:44.112825Z","end":"2026-10-15T07:04:44.313768Z","steps":["trace[1834179262] 'process raft request'  (duration: 200.732219ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:44.313686Z","caller":"traceutil/trace.go:171","msg":"trace[1282779164] linearizableReadLoop","detail":"{readStateIndex:17260; appliedIndex:17259; }","duration":"206.5592ms","start":"2026-10-15T07:04:44.10709Z","end":"2026-10-15T07:04:44.313649Z","steps":["trace[1282779164] 'read index received'  (duration: 124.376405ms)","trace[1282779164] 'applied index is now lower than readState.Index'  (duration: 82.180215ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T07:04:44.314041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.755507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:527"}
{"level":"info","ts":"2026-10-15T07:04:44.31409Z","caller":"traceutil/trace.go:171","msg":"trace[1421593327] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:16501; }","duration":"208.878399ms","start":"2026-10-15T07:04:44.1052Z","end":"2026-10-15T07:04:44.314078Z","steps":["trace[1421593327] 'agreement among raft nodes before linearized reading'  (duration: 208.565621ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:04:48.276404Z","caller":"traceutil/trace.go:171","msg":"trace[1567907897] transaction","detail":"{read_only:false; response_revision:16524; number_of_response:1; }","duration":"141.16167ms","start":"2026-10-15T07:04:48.135212Z","end":"2026-10-15T07:04:48.276374Z","steps":["trace[1567907897] 'process raft request'  (duration: 141.014696ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:06:50.206081Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14596}
{"level":"info","ts":"2026-10-15T07:06:50.297069Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14596,"took":"88.807899ms","hash":1358720782,"current-db-size-bytes":60395520,"current-db-size":"60 MB","current-db-size-in-use-bytes":29728768,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-15T07:06:50.297143Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1358720782,"revision":14596,"compact-revision":12180}
{"level":"info","ts":"2026-10-15T07:09:43.907296Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ca739d563b259b56","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-15T07:09:43.913374Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-10-15T07:09:43.913512Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-10-15T07:10:19.829512Z","caller":"traceutil/trace.go:171","msg":"trace[1645630948] transaction","detail":"{read_only:false; response_revision:19498; number_of_response:1; }","duration":"129.005224ms","start":"2026-10-15T07:10:19.700475Z","end":"2026-10-15T07:10:19.82948Z","steps":["trace[1645630948] 'process raft request'  (duration: 128.8209ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:10:25.487609Z","caller":"traceutil/trace.go:171","msg":"trace[1281679272] transaction","detail":"{read_only:false; response_revision:19556; number_of_response:1; }","duration":"134.060966ms","start":"2026-10-15T07:10:25.353465Z","end":"2026-10-15T07:10:25.487526Z","steps":["trace[1281679272] 'process raft request'  (duration: 133.745748ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:11:50.21304Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17564}
{"level":"info","ts":"2026-10-15T07:11:50.316431Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17564,"took":"99.934318ms","hash":3764241264,"current-db-size-bytes":60395520,"current-db-size":"60 MB","current-db-size-in-use-bytes":34570240,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-10-15T07:11:50.316501Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3764241264,"revision":17564,"compact-revision":14596}
{"level":"info","ts":"2026-10-15T07:16:50.221378Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20496}
{"level":"info","ts":"2026-10-15T07:16:50.351071Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20496,"took":"126.848938ms","hash":382141708,"current-db-size-bytes":60395520,"current-db-size":"60 MB","current-db-size-in-use-bytes":33140736,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-10-15T07:16:50.351127Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":382141708,"revision":20496,"compact-revision":17564}
{"level":"info","ts":"2026-10-15T07:17:44.251398Z","caller":"traceutil/trace.go:171","msg":"trace[94880458] transaction","detail":"{read_only:false; response_revision:23731; number_of_response:1; }","duration":"248.497851ms","start":"2026-10-15T07:17:44.002856Z","end":"2026-10-15T07:17:44.251354Z","steps":["trace[94880458] 'process raft request'  (duration: 248.085741ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:17:44.328145Z","caller":"traceutil/trace.go:171","msg":"trace[288745190] linearizableReadLoop","detail":"{readStateIndex:24840; appliedIndex:24838; }","duration":"162.597268ms","start":"2026-10-15T07:17:44.165509Z","end":"2026-10-15T07:17:44.328106Z","steps":["trace[288745190] 'read index received'  (duration: 85.429482ms)","trace[288745190] 'applied index is now lower than readState.Index'  (duration: 77.166736ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:17:44.328248Z","caller":"traceutil/trace.go:171","msg":"trace[1526974668] transaction","detail":"{read_only:false; response_revision:23732; number_of_response:1; }","duration":"229.777784ms","start":"2026-10-15T07:17:44.098422Z","end":"2026-10-15T07:17:44.3282Z","steps":["trace[1526974668] 'process raft request'  (duration: 200.654618ms)","trace[1526974668] 'compare'  (duration: 28.829649ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T07:17:44.328468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.911257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-15T07:17:44.328602Z","caller":"traceutil/trace.go:171","msg":"trace[221412726] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:23732; }","duration":"163.135482ms","start":"2026-10-15T07:17:44.165438Z","end":"2026-10-15T07:17:44.328574Z","steps":["trace[221412726] 'agreement among raft nodes before linearized reading'  (duration: 162.862135ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:18:00.191142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.807648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-10-15T07:18:00.191257Z","caller":"traceutil/trace.go:171","msg":"trace[1348231521] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:23833; }","duration":"231.995893ms","start":"2026-10-15T07:17:59.959234Z","end":"2026-10-15T07:18:00.19123Z","steps":["trace[1348231521] 'range keys from in-memory index tree'  (duration: 231.584782ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:18:01.058464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.342626ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11193311212728963391 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:23824 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:474 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-15T07:18:01.058604Z","caller":"traceutil/trace.go:171","msg":"trace[1480298156] transaction","detail":"{read_only:false; response_revision:23836; number_of_response:1; }","duration":"402.584208ms","start":"2026-10-15T07:18:00.655995Z","end":"2026-10-15T07:18:01.058579Z","steps":["trace[1480298156] 'process raft request'  (duration: 96.043548ms)","trace[1480298156] 'compare'  (duration: 305.958755ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T07:18:01.058672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:18:00.655962Z","time spent":"402.67399ms","remote":"127.0.0.1:41924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":552,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:23824 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:474 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-15T07:18:01.157124Z","caller":"traceutil/trace.go:171","msg":"trace[343811986] transaction","detail":"{read_only:false; response_revision:23837; number_of_response:1; }","duration":"406.039468ms","start":"2026-10-15T07:18:00.751024Z","end":"2026-10-15T07:18:01.157063Z","steps":["trace[343811986] 'process raft request'  (duration: 405.861613ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:18:01.157365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:18:00.750997Z","time spent":"406.225413ms","remote":"127.0.0.1:41924","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:23825 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-10-15T07:18:01.755702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.614298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-10-15T07:18:01.755848Z","caller":"traceutil/trace.go:171","msg":"trace[355737722] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23837; }","duration":"147.821222ms","start":"2026-10-15T07:18:01.607993Z","end":"2026-10-15T07:18:01.755814Z","steps":["trace[355737722] 'range keys from in-memory index tree'  (duration: 147.358271ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:18:01.755853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.997306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-10-15T07:18:01.755904Z","caller":"traceutil/trace.go:171","msg":"trace[1305253566] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23837; }","duration":"206.093958ms","start":"2026-10-15T07:18:01.549796Z","end":"2026-10-15T07:18:01.75589Z","steps":["trace[1305253566] 'range keys from in-memory index tree'  (duration: 205.852372ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:18:01.75589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.537044ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-15T07:18:01.756136Z","caller":"traceutil/trace.go:171","msg":"trace[126811476] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:23837; }","duration":"315.7554ms","start":"2026-10-15T07:18:01.440295Z","end":"2026-10-15T07:18:01.75605Z","steps":["trace[126811476] 'range keys from in-memory index tree'  (duration: 315.508793ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:18:01.756185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.168398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:528"}
{"level":"warn","ts":"2026-10-15T07:18:01.75626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.667559ms","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-10-15T07:18:01.756306Z","caller":"traceutil/trace.go:171","msg":"trace[1839257792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:23837; }","duration":"200.765741ms","start":"2026-10-15T07:18:01.555526Z","end":"2026-10-15T07:18:01.756292Z","steps":["trace[1839257792] 'range keys from in-memory index tree'  (duration: 200.499453ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:18:01.756301Z","caller":"traceutil/trace.go:171","msg":"trace[1300215832] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:23837; }","duration":"274.353034ms","start":"2026-10-15T07:18:01.48192Z","end":"2026-10-15T07:18:01.756273Z","steps":["trace[1300215832] 'range keys from in-memory index tree'  (duration: 273.880891ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:18:01.756312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.620357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-10-15T07:18:01.756385Z","caller":"traceutil/trace.go:171","msg":"trace[1328274274] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:23837; }","duration":"130.74348ms","start":"2026-10-15T07:18:01.625628Z","end":"2026-10-15T07:18:01.756371Z","steps":["trace[1328274274] 'range keys from in-memory index tree'  (duration: 130.459063ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:18:01.756545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.607397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-10-15T07:18:01.756598Z","caller":"traceutil/trace.go:171","msg":"trace[1139343542] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:23837; }","duration":"380.704209ms","start":"2026-10-15T07:18:01.375883Z","end":"2026-10-15T07:18:01.756588Z","steps":["trace[1139343542] 'range keys from in-memory index tree'  (duration: 380.466444ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:18:01.756627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:18:01.375854Z","time spent":"380.763881ms","remote":"127.0.0.1:41924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-10-15T07:18:01.888903Z","caller":"traceutil/trace.go:171","msg":"trace[101921681] transaction","detail":"{read_only:false; response_revision:23839; number_of_response:1; }","duration":"125.289978ms","start":"2026-10-15T07:18:01.763544Z","end":"2026-10-15T07:18:01.888834Z","steps":["trace[101921681] 'process raft request'  (duration: 125.065732ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:18:01.889057Z","caller":"traceutil/trace.go:171","msg":"trace[1247181172] transaction","detail":"{read_only:false; response_revision:23840; number_of_response:1; }","duration":"125.472444ms","start":"2026-10-15T07:18:01.763574Z","end":"2026-10-15T07:18:01.889046Z","steps":["trace[1247181172] 'process raft request'  (duration: 125.218607ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:18:01.88924Z","caller":"traceutil/trace.go:171","msg":"trace[1908590893] transaction","detail":"{read_only:false; response_revision:23841; number_of_response:1; }","duration":"125.299638ms","start":"2026-10-15T07:18:01.763932Z","end":"2026-10-15T07:18:01.889232Z","steps":["trace[1908590893] 'process raft request'  (duration: 125.079893ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:18:01.889381Z","caller":"traceutil/trace.go:171","msg":"trace[1977564687] transaction","detail":"{read_only:false; response_revision:23843; number_of_response:1; }","duration":"124.393514ms","start":"2026-10-15T07:18:01.76498Z","end":"2026-10-15T07:18:01.889373Z","steps":["trace[1977564687] 'process raft request'  (duration: 124.356583ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:18:01.889535Z","caller":"traceutil/trace.go:171","msg":"trace[518674840] transaction","detail":"{read_only:false; response_revision:23842; number_of_response:1; }","duration":"125.489944ms","start":"2026-10-15T07:18:01.764026Z","end":"2026-10-15T07:18:01.889516Z","steps":["trace[518674840] 'process raft request'  (duration: 125.175535ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:18:56.061244Z","caller":"traceutil/trace.go:171","msg":"trace[439812050] transaction","detail":"{read_only:false; response_revision:24452; number_of_response:1; }","duration":"117.971149ms","start":"2026-10-15T07:18:55.943231Z","end":"2026-10-15T07:18:56.061202Z","steps":["trace[439812050] 'process raft request'  (duration: 117.6912ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:20:58.06276Z","caller":"traceutil/trace.go:171","msg":"trace[1227743823] transaction","detail":"{read_only:false; response_revision:25499; number_of_response:1; }","duration":"104.790704ms","start":"2026-10-15T07:20:57.957938Z","end":"2026-10-15T07:20:58.062729Z","steps":["trace[1227743823] 'process raft request'  (duration: 47.514626ms)","trace[1227743823] 'compare'  (duration: 54.301791ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:21:50.23486Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23352}
{"level":"info","ts":"2026-10-15T07:21:50.372923Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23352,"took":"132.400212ms","hash":113462838,"current-db-size-bytes":60395520,"current-db-size":"60 MB","current-db-size-in-use-bytes":41676800,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-10-15T07:21:50.372983Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":113462838,"revision":23352,"compact-revision":20496}
{"level":"info","ts":"2026-10-15T07:21:50.998547Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006c1d.wal"}
{"level":"info","ts":"2026-10-15T07:21:58.598121Z","caller":"traceutil/trace.go:171","msg":"trace[304100965] transaction","detail":"{read_only:false; response_revision:26638; number_of_response:1; }","duration":"110.00379ms","start":"2026-10-15T07:21:58.488086Z","end":"2026-10-15T07:21:58.59809Z","steps":["trace[304100965] 'process raft request'  (duration: 109.779694ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:21:58.944252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.347898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-15T07:21:58.944388Z","caller":"traceutil/trace.go:171","msg":"trace[912514163] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:26638; }","duration":"138.537252ms","start":"2026-10-15T07:21:58.80583Z","end":"2026-10-15T07:21:58.944368Z","steps":["trace[912514163] 'count revisions from in-memory index tree'  (duration: 138.212044ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:25:01.007386Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ca739d563b259b56","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-15T07:25:01.014605Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-10-15T07:25:01.014681Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-10-15T07:25:19.17816Z","caller":"traceutil/trace.go:171","msg":"trace[1172593230] transaction","detail":"{read_only:false; response_revision:28959; number_of_response:1; }","duration":"169.640008ms","start":"2026-10-15T07:25:19.008491Z","end":"2026-10-15T07:25:19.178131Z","steps":["trace[1172593230] 'process raft request'  (duration: 169.492453ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:25:24.56931Z","caller":"traceutil/trace.go:171","msg":"trace[1116180088] transaction","detail":"{read_only:false; response_revision:29006; number_of_response:1; }","duration":"142.178284ms","start":"2026-10-15T07:25:24.42709Z","end":"2026-10-15T07:25:24.569269Z","steps":["trace[1116180088] 'process raft request'  (duration: 141.943518ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:25:25.172183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.100528ms","expected-duration":"100ms","prefix":"","request":"header:<ID:11193311212728977373 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:28983 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-15T07:25:25.172654Z","caller":"traceutil/trace.go:171","msg":"trace[1790122635] linearizableReadLoop","detail":"{readStateIndex:30334; appliedIndex:30332; }","duration":"503.710276ms","start":"2026-10-15T07:25:24.668921Z","end":"2026-10-15T07:25:25.172632Z","steps":["trace[1790122635] 'read index received'  (duration: 27.838343ms)","trace[1790122635] 'applied index is now lower than readState.Index'  (duration: 475.870833ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:25:25.172859Z","caller":"traceutil/trace.go:171","msg":"trace[839832420] transaction","detail":"{read_only:false; response_revision:29007; number_of_response:1; }","duration":"564.575459ms","start":"2026-10-15T07:25:24.608213Z","end":"2026-10-15T07:25:25.172789Z","steps":["trace[839832420] 'process raft request'  (duration: 88.557991ms)","trace[839832420] 'compare'  (duration: 473.268516ms)"],"step_count":2}
{"level":"info","ts":"2026-10-15T07:25:25.172885Z","caller":"traceutil/trace.go:171","msg":"trace[1773641142] transaction","detail":"{read_only:false; response_revision:29008; number_of_response:1; }","duration":"561.120529ms","start":"2026-10-15T07:25:24.611606Z","end":"2026-10-15T07:25:25.172726Z","steps":["trace[1773641142] 'process raft request'  (duration: 560.894833ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:25:25.173062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:25:24.60818Z","time spent":"564.779605ms","remote":"127.0.0.1:41924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" mod_revision:28983 > success:<request_put:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" value_size:441 >> failure:<request_range:<key:\"/registry/leases/orc-system/f35396c5.k-orc.cloud\" > >"}
{"level":"warn","ts":"2026-10-15T07:25:25.173061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.951266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-10-15T07:25:25.173117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.174936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-15T07:25:25.17316Z","caller":"traceutil/trace.go:171","msg":"trace[1988651516] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:29008; }","duration":"220.094909ms","start":"2026-10-15T07:25:24.953046Z","end":"2026-10-15T07:25:25.173141Z","steps":["trace[1988651516] 'agreement among raft nodes before linearized reading'  (duration: 219.79527ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:25:25.17324Z","caller":"traceutil/trace.go:171","msg":"trace[1117479871] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:29008; }","duration":"251.380502ms","start":"2026-10-15T07:25:24.921839Z","end":"2026-10-15T07:25:25.17322Z","steps":["trace[1117479871] 'agreement among raft nodes before linearized reading'  (duration: 251.075193ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:25:25.173294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:25:24.611575Z","time spent":"561.50901ms","remote":"127.0.0.1:41924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/capo-system/controller-leader-election-capo\" mod_revision:28984 > success:<request_put:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/capo-system/controller-leader-election-capo\" > >"}
{"level":"warn","ts":"2026-10-15T07:25:25.17335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.509562ms","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-10-15T07:25:25.173444Z","caller":"traceutil/trace.go:171","msg":"trace[610354346] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:29008; }","duration":"217.646425ms","start":"2026-10-15T07:25:24.955783Z","end":"2026-10-15T07:25:25.173429Z","steps":["trace[610354346] 'agreement among raft nodes before linearized reading'  (duration: 217.417709ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:25:25.173538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.61149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-10-15T07:25:25.172996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.727015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:647"}
{"level":"info","ts":"2026-10-15T07:25:25.173603Z","caller":"traceutil/trace.go:171","msg":"trace[577137665] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:29008; }","duration":"504.716043ms","start":"2026-10-15T07:25:24.66887Z","end":"2026-10-15T07:25:25.173586Z","steps":["trace[577137665] 'agreement among raft nodes before linearized reading'  (duration: 504.555799ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:25:25.173621Z","caller":"traceutil/trace.go:171","msg":"trace[315760434] range","detail":"{range_begin:/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:29008; }","duration":"380.444195ms","start":"2026-10-15T07:25:24.793158Z","end":"2026-10-15T07:25:25.173602Z","steps":["trace[315760434] 'agreement among raft nodes before linearized reading'  (duration: 379.650094ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:25:25.173601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.690086ms","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-10-15T07:25:25.173648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:25:24.668848Z","time spent":"504.785725ms","remote":"127.0.0.1:41924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-10-15T07:25:25.173674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:25:24.793126Z","time spent":"380.533118ms","remote":"127.0.0.1:41746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":670,"request content":"key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-10-15T07:25:25.173169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.012243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-10-15T07:25:25.173785Z","caller":"traceutil/trace.go:171","msg":"trace[1202667069] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:29008; }","duration":"323.684451ms","start":"2026-10-15T07:25:24.85009Z","end":"2026-10-15T07:25:25.173775Z","steps":["trace[1202667069] 'agreement among raft nodes before linearized reading'  (duration: 322.931121ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:25:25.173839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:25:24.850069Z","time spent":"323.760322ms","remote":"127.0.0.1:41924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-10-15T07:25:25.173725Z","caller":"traceutil/trace.go:171","msg":"trace[1654330487] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:29008; }","duration":"217.83905ms","start":"2026-10-15T07:25:24.955855Z","end":"2026-10-15T07:25:25.173694Z","steps":["trace[1654330487] 'agreement among raft nodes before linearized reading'  (duration: 217.196783ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:25:25.17394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.929145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-15T07:25:25.174028Z","caller":"traceutil/trace.go:171","msg":"trace[1269966355] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:29008; }","duration":"245.034647ms","start":"2026-10-15T07:25:24.928978Z","end":"2026-10-15T07:25:25.174012Z","steps":["trace[1269966355] 'agreement among raft nodes before linearized reading'  (duration: 244.793871ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:25:25.54351Z","caller":"traceutil/trace.go:171","msg":"trace[223622689] transaction","detail":"{read_only:false; response_revision:29009; number_of_response:1; }","duration":"364.394917ms","start":"2026-10-15T07:25:25.179088Z","end":"2026-10-15T07:25:25.543483Z","steps":["trace[223622689] 'process raft request'  (duration: 364.194942ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:25:25.543689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:25:25.17907Z","time spent":"364.517211ms","remote":"127.0.0.1:41924","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:28993 > 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-10-15T07:25:25.575351Z","caller":"traceutil/trace.go:171","msg":"trace[23712791] transaction","detail":"{read_only:false; response_revision:29010; number_of_response:1; }","duration":"395.509956ms","start":"2026-10-15T07:25:25.179808Z","end":"2026-10-15T07:25:25.575318Z","steps":["trace[23712791] 'process raft request'  (duration: 395.179458ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:25:25.575595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:25:25.17979Z","time spent":"395.654689ms","remote":"127.0.0.1:41924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:28985 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-10-15T07:25:25.575822Z","caller":"traceutil/trace.go:171","msg":"trace[1099543285] transaction","detail":"{read_only:false; response_revision:29014; number_of_response:1; }","duration":"392.506418ms","start":"2026-10-15T07:25:25.183297Z","end":"2026-10-15T07:25:25.575803Z","steps":["trace[1099543285] 'process raft request'  (duration: 392.394735ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:25:25.575878Z","caller":"traceutil/trace.go:171","msg":"trace[1058127745] transaction","detail":"{read_only:false; response_revision:29012; number_of_response:1; }","duration":"395.879306ms","start":"2026-10-15T07:25:25.179967Z","end":"2026-10-15T07:25:25.575846Z","steps":["trace[1058127745] 'process raft request'  (duration: 395.580948ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:25:25.57594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:25:25.183284Z","time spent":"392.600861ms","remote":"127.0.0.1:41746","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":629,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:28988 > success:<request_put:<key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" value_size:549 >> failure:<request_range:<key:\"/registry/configmaps/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-15T07:25:25.575949Z","caller":"traceutil/trace.go:171","msg":"trace[806327102] transaction","detail":"{read_only:false; response_revision:29015; number_of_response:1; }","duration":"225.763176ms","start":"2026-10-15T07:25:25.350157Z","end":"2026-10-15T07:25:25.575921Z","steps":["trace[806327102] 'process raft request'  (duration: 225.599481ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:25:25.575971Z","caller":"traceutil/trace.go:171","msg":"trace[2137833493] transaction","detail":"{read_only:false; response_revision:29011; number_of_response:1; }","duration":"396.045099ms","start":"2026-10-15T07:25:25.179909Z","end":"2026-10-15T07:25:25.575954Z","steps":["trace[2137833493] 'process raft request'  (duration: 395.265889ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:25:25.575928Z","caller":"traceutil/trace.go:171","msg":"trace[1657672688] transaction","detail":"{read_only:false; response_revision:29013; number_of_response:1; }","duration":"395.612379ms","start":"2026-10-15T07:25:25.180271Z","end":"2026-10-15T07:25:25.575884Z","steps":["trace[1657672688] 'process raft request'  (duration: 395.357962ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:25:25.576087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:25:25.179952Z","time spent":"396.032819ms","remote":"127.0.0.1:41924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:28991 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-10-15T07:25:25.576541Z","caller":"traceutil/trace.go:171","msg":"trace[151789463] linearizableReadLoop","detail":"{readStateIndex:30340; appliedIndex:30334; }","duration":"360.294031ms","start":"2026-10-15T07:25:25.216198Z","end":"2026-10-15T07:25:25.576492Z","steps":["trace[151789463] 'read index received'  (duration: 327.13877ms)","trace[151789463] 'applied index is now lower than readState.Index'  (duration: 33.11668ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T07:25:25.576599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:25:25.180257Z","time spent":"395.833424ms","remote":"127.0.0.1:41924","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:28990 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-10-15T07:25:25.576803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.573559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:527"}
{"level":"info","ts":"2026-10-15T07:25:25.576862Z","caller":"traceutil/trace.go:171","msg":"trace[20707954] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:29016; }","duration":"360.727633ms","start":"2026-10-15T07:25:25.216116Z","end":"2026-10-15T07:25:25.576844Z","steps":["trace[20707954] 'agreement among raft nodes before linearized reading'  (duration: 360.533248ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:25:25.57693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:25:25.216087Z","time spent":"360.825315ms","remote":"127.0.0.1:41924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":550,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "}
{"level":"warn","ts":"2026-10-15T07:25:25.578198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T07:25:25.179897Z","time spent":"398.206776ms","remote":"127.0.0.1:41924","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:28992 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-10-15T07:26:25.980424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.799095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-15T07:26:25.980521Z","caller":"traceutil/trace.go:171","msg":"trace[1329458309] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:29636; }","duration":"232.941268ms","start":"2026-10-15T07:26:25.747543Z","end":"2026-10-15T07:26:25.980485Z","steps":["trace[1329458309] 'count revisions from in-memory index tree'  (duration: 232.688892ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:26:25.980534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.0392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-15T07:26:25.980671Z","caller":"traceutil/trace.go:171","msg":"trace[1225386826] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:29636; }","duration":"144.305088ms","start":"2026-10-15T07:26:25.836335Z","end":"2026-10-15T07:26:25.98064Z","steps":["trace[1225386826] 'count revisions from in-memory index tree'  (duration: 143.910938ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:26:26.106464Z","caller":"traceutil/trace.go:171","msg":"trace[1912563044] transaction","detail":"{read_only:false; response_revision:29637; number_of_response:1; }","duration":"205.675301ms","start":"2026-10-15T07:26:25.900753Z","end":"2026-10-15T07:26:26.106428Z","steps":["trace[1912563044] 'process raft request'  (duration: 205.420595ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:26:26.106792Z","caller":"traceutil/trace.go:171","msg":"trace[338683667] transaction","detail":"{read_only:false; response_revision:29638; number_of_response:1; }","duration":"206.00292ms","start":"2026-10-15T07:26:25.900753Z","end":"2026-10-15T07:26:26.106756Z","steps":["trace[338683667] 'process raft request'  (duration: 205.63029ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:26:26.107142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.831285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-10-15T07:26:26.107206Z","caller":"traceutil/trace.go:171","msg":"trace[274239679] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:29638; }","duration":"163.966258ms","start":"2026-10-15T07:26:25.943224Z","end":"2026-10-15T07:26:26.10719Z","steps":["trace[274239679] 'agreement among raft nodes before linearized reading'  (duration: 163.695861ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:26:26.107379Z","caller":"traceutil/trace.go:171","msg":"trace[1211555890] linearizableReadLoop","detail":"{readStateIndex:30989; appliedIndex:30987; }","duration":"163.536007ms","start":"2026-10-15T07:26:25.943292Z","end":"2026-10-15T07:26:26.106828Z","steps":["trace[1211555890] 'read index received'  (duration: 162.705745ms)","trace[1211555890] 'applied index is now lower than readState.Index'  (duration: 825.232µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T07:26:26.107599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.493463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-10-15T07:26:26.107861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.618366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-10-15T07:26:26.107902Z","caller":"traceutil/trace.go:171","msg":"trace[1622751135] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:29638; }","duration":"129.701418ms","start":"2026-10-15T07:26:25.978188Z","end":"2026-10-15T07:26:26.10789Z","steps":["trace[1622751135] 'agreement among raft nodes before linearized reading'  (duration: 129.613746ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-15T07:26:26.10788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.106653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-a569e5d1-d8cf-4ea9-afce-f170f3bb9f0b\" ","response":"range_response_count:1 size:1284"}
{"level":"info","ts":"2026-10-15T07:26:26.107973Z","caller":"traceutil/trace.go:171","msg":"trace[1139476003] range","detail":"{range_begin:/registry/persistentvolumes/pvc-a569e5d1-d8cf-4ea9-afce-f170f3bb9f0b; range_end:; response_count:1; response_revision:29638; }","duration":"124.240635ms","start":"2026-10-15T07:26:25.983708Z","end":"2026-10-15T07:26:26.107949Z","steps":["trace[1139476003] 'agreement among raft nodes before linearized reading'  (duration: 123.942868ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:26:26.107645Z","caller":"traceutil/trace.go:171","msg":"trace[1676027984] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:29638; }","duration":"141.587366ms","start":"2026-10-15T07:26:25.966046Z","end":"2026-10-15T07:26:26.107633Z","steps":["trace[1676027984] 'agreement among raft nodes before linearized reading'  (duration: 141.425972ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:26:26.387204Z","caller":"traceutil/trace.go:171","msg":"trace[1331881344] transaction","detail":"{read_only:false; response_revision:29642; number_of_response:1; }","duration":"273.44155ms","start":"2026-10-15T07:26:26.113728Z","end":"2026-10-15T07:26:26.38717Z","steps":["trace[1331881344] 'process raft request'  (duration: 273.279366ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:26:26.387287Z","caller":"traceutil/trace.go:171","msg":"trace[695960892] transaction","detail":"{read_only:false; response_revision:29645; number_of_response:1; }","duration":"271.637104ms","start":"2026-10-15T07:26:26.11564Z","end":"2026-10-15T07:26:26.387277Z","steps":["trace[695960892] 'process raft request'  (duration: 271.432698ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:26:26.387278Z","caller":"traceutil/trace.go:171","msg":"trace[981391730] transaction","detail":"{read_only:false; response_revision:29644; number_of_response:1; }","duration":"273.41347ms","start":"2026-10-15T07:26:26.113829Z","end":"2026-10-15T07:26:26.387243Z","steps":["trace[981391730] 'process raft request'  (duration: 273.225805ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:26:26.387389Z","caller":"traceutil/trace.go:171","msg":"trace[1999957143] transaction","detail":"{read_only:false; response_revision:29641; number_of_response:1; }","duration":"274.115698ms","start":"2026-10-15T07:26:26.113258Z","end":"2026-10-15T07:26:26.387374Z","steps":["trace[1999957143] 'process raft request'  (duration: 273.651676ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:26:26.387459Z","caller":"traceutil/trace.go:171","msg":"trace[1347223299] transaction","detail":"{read_only:false; response_revision:29643; number_of_response:1; }","duration":"273.688797ms","start":"2026-10-15T07:26:26.113759Z","end":"2026-10-15T07:26:26.387448Z","steps":["trace[1347223299] 'process raft request'  (duration: 273.272226ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:26:26.387476Z","caller":"traceutil/trace.go:171","msg":"trace[90495823] transaction","detail":"{read_only:false; response_revision:29640; number_of_response:1; }","duration":"274.246991ms","start":"2026-10-15T07:26:26.11322Z","end":"2026-10-15T07:26:26.387467Z","steps":["trace[90495823] 'process raft request'  (duration: 230.229797ms)","trace[90495823] 'compare'  (duration: 43.214193ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T07:26:47.322657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.721092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:662"}
{"level":"info","ts":"2026-10-15T07:26:47.322795Z","caller":"traceutil/trace.go:171","msg":"trace[1689709591] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:29825; }","duration":"123.938497ms","start":"2026-10-15T07:26:47.198824Z","end":"2026-10-15T07:26:47.322763Z","steps":["trace[1689709591] 'range keys from in-memory index tree'  (duration: 123.343193ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:26:47.465449Z","caller":"traceutil/trace.go:171","msg":"trace[1274622792] linearizableReadLoop","detail":"{readStateIndex:31185; appliedIndex:31184; }","duration":"107.382808ms","start":"2026-10-15T07:26:47.358041Z","end":"2026-10-15T07:26:47.465424Z","steps":["trace[1274622792] 'read index received'  (duration: 107.176693ms)","trace[1274622792] 'applied index is now lower than readState.Index'  (duration: 205.545µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-15T07:26:47.46562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.557182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-15T07:26:47.465654Z","caller":"traceutil/trace.go:171","msg":"trace[1410576646] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:29826; }","duration":"107.646634ms","start":"2026-10-15T07:26:47.357997Z","end":"2026-10-15T07:26:47.465644Z","steps":["trace[1410576646] 'agreement among raft nodes before linearized reading'  (duration: 107.562772ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:26:47.465684Z","caller":"traceutil/trace.go:171","msg":"trace[1408260302] transaction","detail":"{read_only:false; response_revision:29826; number_of_response:1; }","duration":"132.741856ms","start":"2026-10-15T07:26:47.332813Z","end":"2026-10-15T07:26:47.465555Z","steps":["trace[1408260302] 'process raft request'  (duration: 132.478459ms)"],"step_count":1}
{"level":"info","ts":"2026-10-15T07:26:50.25448Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26372}
{"level":"info","ts":"2026-10-15T07:26:50.428737Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26372,"took":"168.554616ms","hash":1230025304,"current-db-size-bytes":60395520,"current-db-size":"60 MB","current-db-size-in-use-bytes":45584384,"current-db-size-in-use":"46 MB"}
{"level":"info","ts":"2026-10-15T07:26:50.428803Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1230025304,"revision":26372,"compact-revision":23352}
{"level":"info","ts":"2026-10-15T07:31:50.261583Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":29847}
{"level":"info","ts":"2026-10-15T07:31:50.443149Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":29847,"took":"177.331985ms","hash":4288827077,"current-db-size-bytes":60395520,"current-db-size":"60 MB","current-db-size-in-use-bytes":37597184,"current-db-size-in-use":"38 MB"}
{"level":"info","ts":"2026-10-15T07:31:50.443288Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4288827077,"revision":29847,"compact-revision":26372}
{"level":"info","ts":"2026-10-15T07:36:50.268825Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33162}
{"level":"info","ts":"2026-10-15T07:36:50.43974Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33162,"took":"165.597413ms","hash":3830168254,"current-db-size-bytes":60395520,"current-db-size":"60 MB","current-db-size-in-use-bytes":34734080,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-10-15T07:36:50.439816Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3830168254,"revision":33162,"compact-revision":29847}
{"level":"info","ts":"2026-10-15T07:41:19.039776Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ca739d563b259b56","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-15T07:41:19.047629Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-10-15T07:41:19.047749Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-10-15T07:41:50.277851Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35833}
{"level":"info","ts":"2026-10-15T07:41:50.418125Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35833,"took":"133.869899ms","hash":2779558626,"current-db-size-bytes":60395520,"current-db-size":"60 MB","current-db-size-in-use-bytes":34455552,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-10-15T07:41:50.41843Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2779558626,"revision":35833,"compact-revision":33162}
{"level":"info","ts":"2026-10-15T07:46:50.287098Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":38547}
{"level":"info","ts":"2026-10-15T07:46:50.474717Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":38547,"took":"181.557218ms","hash":2142190925,"current-db-size-bytes":60395520,"current-db-size":"60 MB","current-db-size-in-use-bytes":35094528,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-10-15T07:46:50.474807Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2142190925,"revision":38547,"compact-revision":35833}
{"level":"info","ts":"2026-10-15T07:51:50.298826Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":41295}
{"level":"info","ts":"2026-10-15T07:51:50.481804Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":41295,"took":"162.246807ms","hash":4244495489,"current-db-size-bytes":60395520,"current-db-size":"60 MB","current-db-size-in-use-bytes":34086912,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-10-15T07:51:50.481857Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4244495489,"revision":41295,"compact-revision":38547}
{"level":"info","ts":"2026-10-15T07:56:50.309349Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":43970}
{"level":"info","ts":"2026-10-15T07:56:50.455796Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":43970,"took":"139.548614ms","hash":848754038,"current-db-size-bytes":60395520,"current-db-size":"60 MB","current-db-size-in-use-bytes":32854016,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-10-15T07:56:50.455856Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":848754038,"revision":43970,"compact-revision":41295}
{"level":"info","ts":"2026-10-15T07:59:00.259964Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ca739d563b259b56","local-member-applied-index":50005,"local-member-snapshot-index":40004,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-15T07:59:00.268422Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":50005}
{"level":"info","ts":"2026-10-15T07:59:00.268765Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":45005}