{"level":"warn","ts":"2026-10-26T19:13:04.932639Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-26T19:13:04.932805Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.159:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.159:2380","--initial-cluster=instance=https://162.253.55.159:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.159:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.159:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-10-26T19:13:04.932929Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-26T19:13:04.932954Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.159:2380"]}
{"level":"info","ts":"2026-10-26T19:13:04.932988Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-10-26T19:13:04.934213Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.159:2379"]}
{"level":"info","ts":"2026-10-26T19:13:04.934359Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.159:2380"],"listen-peer-urls":["https://162.253.55.159:2380"],"advertise-client-urls":["https://162.253.55.159:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.159:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.159:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-10-26T19:13:04.938045Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.273023ms"}
{"level":"info","ts":"2026-10-26T19:13:04.943785Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"94bfbb0e034a3ac2","cluster-id":"9676abcf1742949"}
{"level":"info","ts":"2026-10-26T19:13:04.943891Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"94bfbb0e034a3ac2 switched to configuration voters=()"}
{"level":"info","ts":"2026-10-26T19:13:04.943924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"94bfbb0e034a3ac2 became follower at term 0"}
{"level":"info","ts":"2026-10-26T19:13:04.943948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 94bfbb0e034a3ac2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-26T19:13:04.943987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"94bfbb0e034a3ac2 became follower at term 1"}
{"level":"info","ts":"2026-10-26T19:13:04.944051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"94bfbb0e034a3ac2 switched to configuration voters=(10718491307024202434)"}
{"level":"warn","ts":"2026-10-26T19:13:04.949923Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-26T19:13:04.951839Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-26T19:13:04.953466Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-10-26T19:13:04.956786Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"94bfbb0e034a3ac2","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-26T19:13:04.957037Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"94bfbb0e034a3ac2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-26T19:13:04.957303Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-10-26T19:13:04.957436Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-10-26T19:13:04.957452Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-10-26T19:13:04.962181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"94bfbb0e034a3ac2 switched to configuration voters=(10718491307024202434)"}
{"level":"info","ts":"2026-10-26T19:13:04.962417Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9676abcf1742949","local-member-id":"94bfbb0e034a3ac2","added-peer-id":"94bfbb0e034a3ac2","added-peer-peer-urls":["https://162.253.55.159:2380"]}
{"level":"info","ts":"2026-10-26T19:13:04.964838Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-10-26T19:13:04.964976Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.159:2380"}
{"level":"info","ts":"2026-10-26T19:13:04.965047Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.159:2380"}
{"level":"info","ts":"2026-10-26T19:13:04.965191Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"94bfbb0e034a3ac2","initial-advertise-peer-urls":["https://162.253.55.159:2380"],"listen-peer-urls":["https://162.253.55.159:2380"],"advertise-client-urls":["https://162.253.55.159:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.159:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-26T19:13:04.965236Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-26T19:13:05.044713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"94bfbb0e034a3ac2 is starting a new election at term 1"}
{"level":"info","ts":"2026-10-26T19:13:05.044781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"94bfbb0e034a3ac2 became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-26T19:13:05.044805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"94bfbb0e034a3ac2 received MsgPreVoteResp from 94bfbb0e034a3ac2 at term 1"}
{"level":"info","ts":"2026-10-26T19:13:05.044827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"94bfbb0e034a3ac2 became candidate at term 2"}
{"level":"info","ts":"2026-10-26T19:13:05.044858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"94bfbb0e034a3ac2 received MsgVoteResp from 94bfbb0e034a3ac2 at term 2"}
{"level":"info","ts":"2026-10-26T19:13:05.044879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"94bfbb0e034a3ac2 became leader at term 2"}
{"level":"info","ts":"2026-10-26T19:13:05.044898Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 94bfbb0e034a3ac2 elected leader 94bfbb0e034a3ac2 at term 2"}
{"level":"info","ts":"2026-10-26T19:13:05.046237Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"94bfbb0e034a3ac2","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.159:2379]}","request-path":"/0/members/94bfbb0e034a3ac2/attributes","cluster-id":"9676abcf1742949","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-26T19:13:05.046425Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-26T19:13:05.046457Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-26T19:13:05.046586Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-26T19:13:05.047778Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9676abcf1742949","local-member-id":"94bfbb0e034a3ac2","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-26T19:13:05.047873Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-26T19:13:05.047899Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-26T19:13:05.050284Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-10-26T19:13:05.050564Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-26T19:13:05.050653Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-26T19:13:05.050907Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.159:2379"}
{"level":"info","ts":"2026-10-26T19:13:57.569869Z","caller":"traceutil/trace.go:171","msg":"trace[381160681] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"102.711216ms","start":"2026-10-26T19:13:57.467127Z","end":"2026-10-26T19:13:57.569838Z","steps":["trace[381160681] 'process raft request'  (duration: 102.043641ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:13:57.797576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.893684ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4234124143453123947 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-2p9j6\" mod_revision:536 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-2p9j6\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-2p9j6\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-26T19:13:57.797938Z","caller":"traceutil/trace.go:171","msg":"trace[166619582] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"154.512339ms","start":"2026-10-26T19:13:57.643369Z","end":"2026-10-26T19:13:57.797882Z","steps":["trace[166619582] 'process raft request'  (duration: 154.375956ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:13:57.797942Z","caller":"traceutil/trace.go:171","msg":"trace[1862112314] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"323.00399ms","start":"2026-10-26T19:13:57.474876Z","end":"2026-10-26T19:13:57.79788Z","steps":["trace[1862112314] 'process raft request'  (duration: 201.258277ms)","trace[1862112314] 'compare'  (duration: 120.73444ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:13:57.798226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:13:57.474828Z","time spent":"323.303936ms","remote":"127.0.0.1:58130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-2p9j6\" mod_revision:536 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-2p9j6\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-2p9j6\" > >"}
{"level":"info","ts":"2026-10-26T19:13:58.342251Z","caller":"traceutil/trace.go:171","msg":"trace[406920209] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"188.578304ms","start":"2026-10-26T19:13:58.153635Z","end":"2026-10-26T19:13:58.342213Z","steps":["trace[406920209] 'process raft request'  (duration: 188.336817ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:13:58.616482Z","caller":"traceutil/trace.go:171","msg":"trace[756672998] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"377.111144ms","start":"2026-10-26T19:13:58.239337Z","end":"2026-10-26T19:13:58.616448Z","steps":["trace[756672998] 'process raft request'  (duration: 374.784273ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:13:58.616672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:13:58.239302Z","time spent":"377.264718ms","remote":"127.0.0.1:58040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036257,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:649 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036173 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-10-26T19:13:58.616898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.485324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-10-26T19:13:58.616968Z","caller":"traceutil/trace.go:171","msg":"trace[86610278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:653; }","duration":"263.584538ms","start":"2026-10-26T19:13:58.353357Z","end":"2026-10-26T19:13:58.616942Z","steps":["trace[86610278] 'agreement among raft nodes before linearized reading'  (duration: 263.360502ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:13:58.616942Z","caller":"traceutil/trace.go:171","msg":"trace[650846334] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:677; }","duration":"262.937641ms","start":"2026-10-26T19:13:58.353416Z","end":"2026-10-26T19:13:58.616353Z","steps":["trace[650846334] 'read index received'  (duration: 259.488954ms)","trace[650846334] 'applied index is now lower than readState.Index'  (duration: 3.447477ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:13:58.617301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.460332ms","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-26T19:13:58.617371Z","caller":"traceutil/trace.go:171","msg":"trace[1703289279] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:653; }","duration":"258.593295ms","start":"2026-10-26T19:13:58.35876Z","end":"2026-10-26T19:13:58.617354Z","steps":["trace[1703289279] 'agreement among raft nodes before linearized reading'  (duration: 258.355ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:14:14.828858Z","caller":"traceutil/trace.go:171","msg":"trace[1927414256] linearizableReadLoop","detail":"{readStateIndex:858; appliedIndex:857; }","duration":"214.673929ms","start":"2026-10-26T19:14:14.614142Z","end":"2026-10-26T19:14:14.828816Z","steps":["trace[1927414256] 'read index received'  (duration: 214.335231ms)","trace[1927414256] 'applied index is now lower than readState.Index'  (duration: 337.108µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:14:14.828983Z","caller":"traceutil/trace.go:171","msg":"trace[650258842] transaction","detail":"{read_only:false; response_revision:827; number_of_response:1; }","duration":"235.830824ms","start":"2026-10-26T19:14:14.593123Z","end":"2026-10-26T19:14:14.828954Z","steps":["trace[650258842] 'process raft request'  (duration: 235.391254ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:14:14.829153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.993756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-26T19:14:14.829212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.850853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:14:14.829264Z","caller":"traceutil/trace.go:171","msg":"trace[308559259] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:827; }","duration":"215.122179ms","start":"2026-10-26T19:14:14.614119Z","end":"2026-10-26T19:14:14.829241Z","steps":["trace[308559259] 'agreement among raft nodes before linearized reading'  (duration: 214.941405ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:14:14.829329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.498818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:14:14.829378Z","caller":"traceutil/trace.go:171","msg":"trace[412053400] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:827; }","duration":"146.5634ms","start":"2026-10-26T19:14:14.6828Z","end":"2026-10-26T19:14:14.829364Z","steps":["trace[412053400] 'agreement among raft nodes before linearized reading'  (duration: 146.496238ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:14:14.829272Z","caller":"traceutil/trace.go:171","msg":"trace[1761872953] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:827; }","duration":"215.008396ms","start":"2026-10-26T19:14:14.614243Z","end":"2026-10-26T19:14:14.829251Z","steps":["trace[1761872953] 'agreement among raft nodes before linearized reading'  (duration: 214.876583ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:14:14.829643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.853859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-26T19:14:14.829597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.633675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-10-26T19:14:14.829717Z","caller":"traceutil/trace.go:171","msg":"trace[40163991] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:827; }","duration":"147.91327ms","start":"2026-10-26T19:14:14.68176Z","end":"2026-10-26T19:14:14.829673Z","steps":["trace[40163991] 'agreement among raft nodes before linearized reading'  (duration: 147.841829ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:14:14.829763Z","caller":"traceutil/trace.go:171","msg":"trace[1335764873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:827; }","duration":"107.84786ms","start":"2026-10-26T19:14:14.721883Z","end":"2026-10-26T19:14:14.829731Z","steps":["trace[1335764873] 'agreement among raft nodes before linearized reading'  (duration: 107.355109ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:14:14.829895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.215419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-26T19:14:14.829916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.274153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:14:14.829935Z","caller":"traceutil/trace.go:171","msg":"trace[2135272385] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:827; }","duration":"186.283271ms","start":"2026-10-26T19:14:14.64364Z","end":"2026-10-26T19:14:14.829923Z","steps":["trace[2135272385] 'agreement among raft nodes before linearized reading'  (duration: 186.21951ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:14:14.829944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.24928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-26T19:14:14.829945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.241747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:14:14.830009Z","caller":"traceutil/trace.go:171","msg":"trace[2053788753] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:827; }","duration":"186.348212ms","start":"2026-10-26T19:14:14.643638Z","end":"2026-10-26T19:14:14.829987Z","steps":["trace[2053788753] 'agreement among raft nodes before linearized reading'  (duration: 186.24688ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:14:14.830038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.295339ms","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:5"}
{"level":"info","ts":"2026-10-26T19:14:14.830063Z","caller":"traceutil/trace.go:171","msg":"trace[848107132] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:827; }","duration":"185.390981ms","start":"2026-10-26T19:14:14.644637Z","end":"2026-10-26T19:14:14.830028Z","steps":["trace[848107132] 'agreement among raft nodes before linearized reading'  (duration: 185.224838ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:14:14.829955Z","caller":"traceutil/trace.go:171","msg":"trace[2108527105] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:827; }","duration":"215.336803ms","start":"2026-10-26T19:14:14.614605Z","end":"2026-10-26T19:14:14.829942Z","steps":["trace[2108527105] 'agreement among raft nodes before linearized reading'  (duration: 215.269952ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:14:14.830102Z","caller":"traceutil/trace.go:171","msg":"trace[1687430384] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:827; }","duration":"148.415571ms","start":"2026-10-26T19:14:14.681659Z","end":"2026-10-26T19:14:14.830075Z","steps":["trace[1687430384] 'agreement among raft nodes before linearized reading'  (duration: 148.326159ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:14:45.1772Z","caller":"traceutil/trace.go:171","msg":"trace[2081393872] linearizableReadLoop","detail":"{readStateIndex:1264; appliedIndex:1263; }","duration":"143.496834ms","start":"2026-10-26T19:14:45.033672Z","end":"2026-10-26T19:14:45.177169Z","steps":["trace[2081393872] 'read index received'  (duration: 143.266039ms)","trace[2081393872] 'applied index is now lower than readState.Index'  (duration: 229.265µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:14:45.177295Z","caller":"traceutil/trace.go:171","msg":"trace[109925484] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"145.414618ms","start":"2026-10-26T19:14:45.03185Z","end":"2026-10-26T19:14:45.177265Z","steps":["trace[109925484] 'process raft request'  (duration: 145.04214ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:14:45.177453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.768351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-10-26T19:14:45.177501Z","caller":"traceutil/trace.go:171","msg":"trace[1453292115] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1226; }","duration":"143.894043ms","start":"2026-10-26T19:14:45.033594Z","end":"2026-10-26T19:14:45.177488Z","steps":["trace[1453292115] 'agreement among raft nodes before linearized reading'  (duration: 143.704329ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:14:45.265908Z","caller":"traceutil/trace.go:171","msg":"trace[829014789] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"230.879501ms","start":"2026-10-26T19:14:45.034998Z","end":"2026-10-26T19:14:45.265877Z","steps":["trace[829014789] 'process raft request'  (duration: 199.385209ms)","trace[829014789] 'compare'  (duration: 31.164585ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:15:33.599366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.147496ms","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-26T19:15:33.599477Z","caller":"traceutil/trace.go:171","msg":"trace[974908111] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1900; }","duration":"147.299819ms","start":"2026-10-26T19:15:33.452154Z","end":"2026-10-26T19:15:33.599454Z","steps":["trace[974908111] 'range keys from in-memory index tree'  (duration: 146.996043ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:16:20.048182Z","caller":"traceutil/trace.go:171","msg":"trace[597391705] transaction","detail":"{read_only:false; response_revision:2202; number_of_response:1; }","duration":"155.0646ms","start":"2026-10-26T19:16:19.893082Z","end":"2026-10-26T19:16:20.048146Z","steps":["trace[597391705] 'process raft request'  (duration: 154.869385ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:16:20.25791Z","caller":"traceutil/trace.go:171","msg":"trace[641607787] transaction","detail":"{read_only:false; response_revision:2203; number_of_response:1; }","duration":"347.576486ms","start":"2026-10-26T19:16:19.910303Z","end":"2026-10-26T19:16:20.25788Z","steps":["trace[641607787] 'process raft request'  (duration: 271.222923ms)","trace[641607787] 'compare'  (duration: 76.223631ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:16:20.258375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:16:19.910279Z","time spent":"347.732399ms","remote":"127.0.0.1:58194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2193 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-10-26T19:16:25.450312Z","caller":"traceutil/trace.go:171","msg":"trace[1790403808] transaction","detail":"{read_only:false; response_revision:2233; number_of_response:1; }","duration":"145.062914ms","start":"2026-10-26T19:16:25.305192Z","end":"2026-10-26T19:16:25.450254Z","steps":["trace[1790403808] 'process raft request'  (duration: 104.855137ms)","trace[1790403808] 'compare'  (duration: 39.9081ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:17:08.765459Z","caller":"traceutil/trace.go:171","msg":"trace[1795842380] transaction","detail":"{read_only:false; response_revision:2513; number_of_response:1; }","duration":"191.598571ms","start":"2026-10-26T19:17:08.57383Z","end":"2026-10-26T19:17:08.765429Z","steps":["trace[1795842380] 'process raft request'  (duration: 168.304406ms)","trace[1795842380] 'compare'  (duration: 22.907357ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:17:08.771778Z","caller":"traceutil/trace.go:171","msg":"trace[1340211547] linearizableReadLoop","detail":"{readStateIndex:2607; appliedIndex:2605; }","duration":"125.824108ms","start":"2026-10-26T19:17:08.645894Z","end":"2026-10-26T19:17:08.771719Z","steps":["trace[1340211547] 'read index received'  (duration: 96.2549ms)","trace[1340211547] 'applied index is now lower than readState.Index'  (duration: 29.567618ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:17:08.771838Z","caller":"traceutil/trace.go:171","msg":"trace[910544297] transaction","detail":"{read_only:false; response_revision:2514; number_of_response:1; }","duration":"197.70614ms","start":"2026-10-26T19:17:08.574096Z","end":"2026-10-26T19:17:08.771802Z","steps":["trace[910544297] 'process raft request'  (duration: 197.433494ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:17:08.772094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.172856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-10-26T19:17:08.772169Z","caller":"traceutil/trace.go:171","msg":"trace[983105310] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2514; }","duration":"126.315189ms","start":"2026-10-26T19:17:08.645816Z","end":"2026-10-26T19:17:08.772131Z","steps":["trace[983105310] 'agreement among raft nodes before linearized reading'  (duration: 126.062554ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:17:42.841375Z","caller":"traceutil/trace.go:171","msg":"trace[1098128953] transaction","detail":"{read_only:false; response_revision:2699; number_of_response:1; }","duration":"114.339478ms","start":"2026-10-26T19:17:42.726995Z","end":"2026-10-26T19:17:42.841334Z","steps":["trace[1098128953] 'process raft request'  (duration: 114.031631ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:17:43.021854Z","caller":"traceutil/trace.go:171","msg":"trace[954994597] transaction","detail":"{read_only:false; response_revision:2700; number_of_response:1; }","duration":"118.180505ms","start":"2026-10-26T19:17:42.903644Z","end":"2026-10-26T19:17:43.021824Z","steps":["trace[954994597] 'process raft request'  (duration: 75.876671ms)","trace[954994597] 'compare'  (duration: 42.068409ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:17:43.022751Z","caller":"traceutil/trace.go:171","msg":"trace[962024144] transaction","detail":"{read_only:false; response_revision:2701; number_of_response:1; }","duration":"112.264122ms","start":"2026-10-26T19:17:42.91046Z","end":"2026-10-26T19:17:43.022724Z","steps":["trace[962024144] 'process raft request'  (duration: 112.074108ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:21:21.710599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.840036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-10-26T19:21:21.710694Z","caller":"traceutil/trace.go:171","msg":"trace[121387319] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4025; }","duration":"111.983798ms","start":"2026-10-26T19:21:21.598693Z","end":"2026-10-26T19:21:21.710676Z","steps":["trace[121387319] 'range keys from in-memory index tree'  (duration: 111.662402ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:22:44.527934Z","caller":"traceutil/trace.go:171","msg":"trace[1408142638] transaction","detail":"{read_only:false; number_of_response:1; response_revision:5003; }","duration":"134.224124ms","start":"2026-10-26T19:22:44.393639Z","end":"2026-10-26T19:22:44.527863Z","steps":["trace[1408142638] 'process raft request'  (duration: 36.085671ms)","trace[1408142638] 'compare'  (duration: 97.893108ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:22:50.341909Z","caller":"traceutil/trace.go:171","msg":"trace[330384783] transaction","detail":"{read_only:false; response_revision:5146; number_of_response:1; }","duration":"100.692051ms","start":"2026-10-26T19:22:50.241172Z","end":"2026-10-26T19:22:50.341864Z","steps":["trace[330384783] 'process raft request'  (duration: 100.549178ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:22:50.341924Z","caller":"traceutil/trace.go:171","msg":"trace[1085053313] transaction","detail":"{read_only:false; response_revision:5145; number_of_response:1; }","duration":"100.811925ms","start":"2026-10-26T19:22:50.240991Z","end":"2026-10-26T19:22:50.341803Z","steps":["trace[1085053313] 'process raft request'  (duration: 100.419896ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:22:50.342033Z","caller":"traceutil/trace.go:171","msg":"trace[1618290066] transaction","detail":"{read_only:false; response_revision:5147; number_of_response:1; }","duration":"100.21942ms","start":"2026-10-26T19:22:50.241759Z","end":"2026-10-26T19:22:50.341978Z","steps":["trace[1618290066] 'process raft request'  (duration: 100.004195ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:22:52.831165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.936019ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4234124143453135088 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5207 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-26T19:22:52.831334Z","caller":"traceutil/trace.go:171","msg":"trace[63365957] linearizableReadLoop","detail":"{readStateIndex:5436; appliedIndex:5435; }","duration":"207.449501ms","start":"2026-10-26T19:22:52.623861Z","end":"2026-10-26T19:22:52.831311Z","steps":["trace[63365957] 'read index received'  (duration: 102.210225ms)","trace[63365957] 'applied index is now lower than readState.Index'  (duration: 105.237666ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:22:52.831422Z","caller":"traceutil/trace.go:171","msg":"trace[14668821] transaction","detail":"{read_only:false; response_revision:5238; number_of_response:1; }","duration":"242.230582ms","start":"2026-10-26T19:22:52.589138Z","end":"2026-10-26T19:22:52.831368Z","steps":["trace[14668821] 'process raft request'  (duration: 136.947296ms)","trace[14668821] 'compare'  (duration: 104.663062ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:22:52.831542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.649335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12428"}
{"level":"info","ts":"2026-10-26T19:22:52.831585Z","caller":"traceutil/trace.go:171","msg":"trace[797401917] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5238; }","duration":"207.735948ms","start":"2026-10-26T19:22:52.623837Z","end":"2026-10-26T19:22:52.831573Z","steps":["trace[797401917] 'agreement among raft nodes before linearized reading'  (duration: 207.523473ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:22:52.831624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.542693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-302f343a-9e59-434d-8ed2-967609bf2524\" ","response":"range_response_count:1 size:3721"}
{"level":"info","ts":"2026-10-26T19:22:52.831669Z","caller":"traceutil/trace.go:171","msg":"trace[1819188910] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-302f343a-9e59-434d-8ed2-967609bf2524; range_end:; response_count:1; response_revision:5238; }","duration":"145.630355ms","start":"2026-10-26T19:22:52.686025Z","end":"2026-10-26T19:22:52.831655Z","steps":["trace[1819188910] 'agreement among raft nodes before linearized reading'  (duration: 145.42727ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:22:54.871674Z","caller":"traceutil/trace.go:171","msg":"trace[366847190] transaction","detail":"{read_only:false; response_revision:5271; number_of_response:1; }","duration":"115.189542ms","start":"2026-10-26T19:22:54.756461Z","end":"2026-10-26T19:22:54.87165Z","steps":["trace[366847190] 'process raft request'  (duration: 114.980107ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:23:06.110095Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2822}
{"level":"info","ts":"2026-10-26T19:23:06.180781Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2822,"took":"69.368648ms","hash":4101830580,"current-db-size-bytes":54747136,"current-db-size":"55 MB","current-db-size-in-use-bytes":30040064,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-26T19:23:06.180851Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4101830580,"revision":2822,"compact-revision":-1}
{"level":"warn","ts":"2026-10-26T19:23:08.922566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.149761ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4234124143453135715 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/openstack/memcached-metrics\" mod_revision:5498 > success:<request_put:<key:\"/registry/services/endpoints/openstack/memcached-metrics\" value_size:466 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/memcached-metrics\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-26T19:23:08.922703Z","caller":"traceutil/trace.go:171","msg":"trace[1683269505] transaction","detail":"{read_only:false; response_revision:5508; number_of_response:1; }","duration":"171.313319ms","start":"2026-10-26T19:23:08.751362Z","end":"2026-10-26T19:23:08.922675Z","steps":["trace[1683269505] 'process raft request'  (duration: 33.942333ms)","trace[1683269505] 'compare'  (duration: 136.861145ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:23:08.931489Z","caller":"traceutil/trace.go:171","msg":"trace[701516063] transaction","detail":"{read_only:false; response_revision:5510; number_of_response:1; }","duration":"179.774061ms","start":"2026-10-26T19:23:08.751694Z","end":"2026-10-26T19:23:08.931468Z","steps":["trace[701516063] 'process raft request'  (duration: 179.526516ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:23:08.931506Z","caller":"traceutil/trace.go:171","msg":"trace[689840274] linearizableReadLoop","detail":"{readStateIndex:5719; appliedIndex:5716; }","duration":"136.914646ms","start":"2026-10-26T19:23:08.794582Z","end":"2026-10-26T19:23:08.931497Z","steps":["trace[689840274] 'read index received'  (duration: 136.535817ms)","trace[689840274] 'applied index is now lower than readState.Index'  (duration: 378.329µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:23:08.931691Z","caller":"traceutil/trace.go:171","msg":"trace[768083135] transaction","detail":"{read_only:false; response_revision:5511; number_of_response:1; }","duration":"178.631856ms","start":"2026-10-26T19:23:08.753046Z","end":"2026-10-26T19:23:08.931678Z","steps":["trace[768083135] 'process raft request'  (duration: 178.341719ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:23:08.931853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.222253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:23:08.931328Z","caller":"traceutil/trace.go:171","msg":"trace[1084802814] transaction","detail":"{read_only:false; response_revision:5509; number_of_response:1; }","duration":"179.634988ms","start":"2026-10-26T19:23:08.751655Z","end":"2026-10-26T19:23:08.93129Z","steps":["trace[1084802814] 'process raft request'  (duration: 179.427934ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:23:08.932575Z","caller":"traceutil/trace.go:171","msg":"trace[1759670870] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5511; }","duration":"137.982621ms","start":"2026-10-26T19:23:08.794557Z","end":"2026-10-26T19:23:08.93254Z","steps":["trace[1759670870] 'agreement among raft nodes before linearized reading'  (duration: 137.142621ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:23:08.933511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.789086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-10-26T19:23:08.933559Z","caller":"traceutil/trace.go:171","msg":"trace[356549449] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5512; }","duration":"137.836217ms","start":"2026-10-26T19:23:08.795708Z","end":"2026-10-26T19:23:08.933545Z","steps":["trace[356549449] 'agreement among raft nodes before linearized reading'  (duration: 137.591571ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:23:16.034078Z","caller":"traceutil/trace.go:171","msg":"trace[309657986] transaction","detail":"{read_only:false; response_revision:5654; number_of_response:1; }","duration":"222.197258ms","start":"2026-10-26T19:23:15.811819Z","end":"2026-10-26T19:23:16.034016Z","steps":["trace[309657986] 'process raft request'  (duration: 143.120217ms)","trace[309657986] 'compare'  (duration: 78.903087ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:28:06.116832Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5460}
{"level":"info","ts":"2026-10-26T19:28:06.213284Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5460,"took":"94.679271ms","hash":3849060199,"current-db-size-bytes":54747136,"current-db-size":"55 MB","current-db-size-in-use-bytes":25776128,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-10-26T19:28:06.213368Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3849060199,"revision":5460,"compact-revision":2822}
{"level":"info","ts":"2026-10-26T19:29:27.129985Z","caller":"traceutil/trace.go:171","msg":"trace[1056147597] transaction","detail":"{read_only:false; response_revision:8531; number_of_response:1; }","duration":"189.69143ms","start":"2026-10-26T19:29:26.940271Z","end":"2026-10-26T19:29:27.129962Z","steps":["trace[1056147597] 'process raft request'  (duration: 189.535207ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:29:38.352857Z","caller":"traceutil/trace.go:171","msg":"trace[1966189498] linearizableReadLoop","detail":"{readStateIndex:8895; appliedIndex:8894; }","duration":"122.93533ms","start":"2026-10-26T19:29:38.229897Z","end":"2026-10-26T19:29:38.352832Z","steps":["trace[1966189498] 'read index received'  (duration: 122.676654ms)","trace[1966189498] 'applied index is now lower than readState.Index'  (duration: 257.506µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:29:38.353112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.197806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12428"}
{"level":"info","ts":"2026-10-26T19:29:38.352986Z","caller":"traceutil/trace.go:171","msg":"trace[1960503633] transaction","detail":"{read_only:false; response_revision:8589; number_of_response:1; }","duration":"125.260113ms","start":"2026-10-26T19:29:38.227684Z","end":"2026-10-26T19:29:38.352944Z","steps":["trace[1960503633] 'process raft request'  (duration: 124.952176ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:29:38.353188Z","caller":"traceutil/trace.go:171","msg":"trace[1096619457] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8589; }","duration":"123.286899ms","start":"2026-10-26T19:29:38.229881Z","end":"2026-10-26T19:29:38.353168Z","steps":["trace[1096619457] 'agreement among raft nodes before linearized reading'  (duration: 123.067884ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:29:39.960872Z","caller":"traceutil/trace.go:171","msg":"trace[1369817472] transaction","detail":"{read_only:false; response_revision:8598; number_of_response:1; }","duration":"124.012725ms","start":"2026-10-26T19:29:39.836829Z","end":"2026-10-26T19:29:39.960842Z","steps":["trace[1369817472] 'process raft request'  (duration: 123.82843ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:29:40.038715Z","caller":"traceutil/trace.go:171","msg":"trace[37593530] linearizableReadLoop","detail":"{readStateIndex:8906; appliedIndex:8904; }","duration":"175.639462ms","start":"2026-10-26T19:29:39.863054Z","end":"2026-10-26T19:29:40.038694Z","steps":["trace[37593530] 'read index received'  (duration: 97.758281ms)","trace[37593530] 'applied index is now lower than readState.Index'  (duration: 77.880211ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:29:40.038802Z","caller":"traceutil/trace.go:171","msg":"trace[1114480053] transaction","detail":"{read_only:false; response_revision:8599; number_of_response:1; }","duration":"197.324863ms","start":"2026-10-26T19:29:39.84147Z","end":"2026-10-26T19:29:40.038795Z","steps":["trace[1114480053] 'process raft request'  (duration: 197.101148ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:29:40.03901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.222688ms","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:5"}
{"level":"info","ts":"2026-10-26T19:29:40.039115Z","caller":"traceutil/trace.go:171","msg":"trace[634715375] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:8599; }","duration":"135.396641ms","start":"2026-10-26T19:29:39.903692Z","end":"2026-10-26T19:29:40.039089Z","steps":["trace[634715375] 'agreement among raft nodes before linearized reading'  (duration: 135.170266ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:29:40.03912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.039691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-10-26T19:29:40.039209Z","caller":"traceutil/trace.go:171","msg":"trace[1256934542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8599; }","duration":"176.199164ms","start":"2026-10-26T19:29:39.86299Z","end":"2026-10-26T19:29:40.039189Z","steps":["trace[1256934542] 'agreement among raft nodes before linearized reading'  (duration: 175.901368ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:30:22.330757Z","caller":"traceutil/trace.go:171","msg":"trace[2015082442] transaction","detail":"{read_only:false; response_revision:8919; number_of_response:1; }","duration":"196.811068ms","start":"2026-10-26T19:30:22.133917Z","end":"2026-10-26T19:30:22.330728Z","steps":["trace[2015082442] 'process raft request'  (duration: 196.631934ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:30:22.429106Z","caller":"traceutil/trace.go:171","msg":"trace[58650574] transaction","detail":"{read_only:false; response_revision:8920; number_of_response:1; }","duration":"283.013666ms","start":"2026-10-26T19:30:22.14604Z","end":"2026-10-26T19:30:22.429054Z","steps":["trace[58650574] 'process raft request'  (duration: 235.207436ms)","trace[58650574] 'compare'  (duration: 47.401971ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:30:22.429169Z","caller":"traceutil/trace.go:171","msg":"trace[736894433] transaction","detail":"{read_only:false; response_revision:8921; number_of_response:1; }","duration":"238.351167ms","start":"2026-10-26T19:30:22.190788Z","end":"2026-10-26T19:30:22.429139Z","steps":["trace[736894433] 'process raft request'  (duration: 238.141152ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:30:22.429107Z","caller":"traceutil/trace.go:171","msg":"trace[1417711662] linearizableReadLoop","detail":"{readStateIndex:9240; appliedIndex:9237; }","duration":"180.204052ms","start":"2026-10-26T19:30:22.248868Z","end":"2026-10-26T19:30:22.429072Z","steps":["trace[1417711662] 'read index received'  (duration: 81.720376ms)","trace[1417711662] 'applied index is now lower than readState.Index'  (duration: 98.482406ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:30:22.429319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.429827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-10-26T19:30:22.429392Z","caller":"traceutil/trace.go:171","msg":"trace[941969133] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8921; }","duration":"180.55295ms","start":"2026-10-26T19:30:22.248824Z","end":"2026-10-26T19:30:22.429377Z","steps":["trace[941969133] 'agreement among raft nodes before linearized reading'  (duration: 180.350346ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:30:22.429488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.298096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-26T19:30:22.429583Z","caller":"traceutil/trace.go:171","msg":"trace[884863123] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:8921; }","duration":"165.425149ms","start":"2026-10-26T19:30:22.264131Z","end":"2026-10-26T19:30:22.429556Z","steps":["trace[884863123] 'agreement among raft nodes before linearized reading'  (duration: 165.246315ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:30:37.584049Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024a8.wal"}
{"level":"info","ts":"2026-10-26T19:31:44.59514Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"94bfbb0e034a3ac2","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-26T19:31:44.602668Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-10-26T19:31:44.602773Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-10-26T19:33:06.12342Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7849}
{"level":"info","ts":"2026-10-26T19:33:06.200751Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7849,"took":"75.300741ms","hash":911172759,"current-db-size-bytes":54747136,"current-db-size":"55 MB","current-db-size-in-use-bytes":28639232,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-10-26T19:33:06.20082Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":911172759,"revision":7849,"compact-revision":5460}
{"level":"warn","ts":"2026-10-26T19:35:15.638425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.086033ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4234124143453152245 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:11505 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-26T19:35:15.638629Z","caller":"traceutil/trace.go:171","msg":"trace[1279159725] transaction","detail":"{read_only:false; response_revision:11515; number_of_response:1; }","duration":"301.375415ms","start":"2026-10-26T19:35:15.337221Z","end":"2026-10-26T19:35:15.638597Z","steps":["trace[1279159725] 'process raft request'  (duration: 48.973445ms)","trace[1279159725] 'compare'  (duration: 251.889979ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:35:15.638748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:35:15.337193Z","time spent":"301.493078ms","remote":"127.0.0.1:58194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:11505 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-26T19:35:15.647827Z","caller":"traceutil/trace.go:171","msg":"trace[1693370180] transaction","detail":"{read_only:false; response_revision:11516; number_of_response:1; }","duration":"177.874347ms","start":"2026-10-26T19:35:15.469934Z","end":"2026-10-26T19:35:15.647808Z","steps":["trace[1693370180] 'process raft request'  (duration: 177.787515ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:35:15.661002Z","caller":"traceutil/trace.go:171","msg":"trace[767554169] linearizableReadLoop","detail":"{readStateIndex:11913; appliedIndex:11911; }","duration":"131.253375ms","start":"2026-10-26T19:35:15.529724Z","end":"2026-10-26T19:35:15.660977Z","steps":["trace[767554169] 'read index received'  (duration: 118.026497ms)","trace[767554169] 'applied index is now lower than readState.Index'  (duration: 13.226028ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:35:15.661119Z","caller":"traceutil/trace.go:171","msg":"trace[1528877795] transaction","detail":"{read_only:false; response_revision:11517; number_of_response:1; }","duration":"158.801805ms","start":"2026-10-26T19:35:15.502297Z","end":"2026-10-26T19:35:15.661099Z","steps":["trace[1528877795] 'process raft request'  (duration: 158.589481ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:35:15.661211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.456295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-26T19:35:15.66123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.230891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:35:15.661264Z","caller":"traceutil/trace.go:171","msg":"trace[588802804] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:11517; }","duration":"130.530607ms","start":"2026-10-26T19:35:15.530718Z","end":"2026-10-26T19:35:15.661249Z","steps":["trace[588802804] 'agreement among raft nodes before linearized reading'  (duration: 130.457055ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:35:15.661311Z","caller":"traceutil/trace.go:171","msg":"trace[256253092] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:11517; }","duration":"130.311942ms","start":"2026-10-26T19:35:15.530962Z","end":"2026-10-26T19:35:15.661274Z","steps":["trace[256253092] 'agreement among raft nodes before linearized reading'  (duration: 130.21836ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:35:15.661382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.147541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:35:15.661447Z","caller":"traceutil/trace.go:171","msg":"trace[1444559711] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:11517; }","duration":"131.235783ms","start":"2026-10-26T19:35:15.530192Z","end":"2026-10-26T19:35:15.661428Z","steps":["trace[1444559711] 'agreement among raft nodes before linearized reading'  (duration: 130.981307ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:35:15.661426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.6874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-26T19:35:15.661511Z","caller":"traceutil/trace.go:171","msg":"trace[1732210691] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:11517; }","duration":"130.804343ms","start":"2026-10-26T19:35:15.530685Z","end":"2026-10-26T19:35:15.66149Z","steps":["trace[1732210691] 'agreement among raft nodes before linearized reading'  (duration: 130.68467ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:35:15.661574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.280533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5079"}
{"level":"info","ts":"2026-10-26T19:35:15.661622Z","caller":"traceutil/trace.go:171","msg":"trace[1090303101] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:11517; }","duration":"127.331105ms","start":"2026-10-26T19:35:15.534276Z","end":"2026-10-26T19:35:15.661608Z","steps":["trace[1090303101] 'agreement among raft nodes before linearized reading'  (duration: 127.13675ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:35:15.66167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.948361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:667"}
{"level":"info","ts":"2026-10-26T19:35:15.661719Z","caller":"traceutil/trace.go:171","msg":"trace[481795306] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:11517; }","duration":"131.998372ms","start":"2026-10-26T19:35:15.529706Z","end":"2026-10-26T19:35:15.661705Z","steps":["trace[481795306] 'agreement among raft nodes before linearized reading'  (duration: 131.406468ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:38:06.130669Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10328}
{"level":"info","ts":"2026-10-26T19:38:06.221176Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10328,"took":"87.875314ms","hash":1914887673,"current-db-size-bytes":54747136,"current-db-size":"55 MB","current-db-size-in-use-bytes":27357184,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-10-26T19:38:06.221365Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1914887673,"revision":10328,"compact-revision":7849}
{"level":"info","ts":"2026-10-26T19:41:09.127196Z","caller":"traceutil/trace.go:171","msg":"trace[632871075] transaction","detail":"{read_only:false; response_revision:13922; number_of_response:1; }","duration":"131.859422ms","start":"2026-10-26T19:41:08.995314Z","end":"2026-10-26T19:41:09.127174Z","steps":["trace[632871075] 'process raft request'  (duration: 131.462363ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:41:47.547556Z","caller":"traceutil/trace.go:171","msg":"trace[196954883] linearizableReadLoop","detail":"{readStateIndex:14629; appliedIndex:14628; }","duration":"140.474768ms","start":"2026-10-26T19:41:47.407052Z","end":"2026-10-26T19:41:47.547526Z","steps":["trace[196954883] 'read index received'  (duration: 140.321914ms)","trace[196954883] 'applied index is now lower than readState.Index'  (duration: 151.774µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:41:47.547641Z","caller":"traceutil/trace.go:171","msg":"trace[1432513393] transaction","detail":"{read_only:false; response_revision:14142; number_of_response:1; }","duration":"213.032878ms","start":"2026-10-26T19:41:47.334561Z","end":"2026-10-26T19:41:47.547594Z","steps":["trace[1432513393] 'process raft request'  (duration: 212.793573ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:41:47.547845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.780874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1857"}
{"level":"info","ts":"2026-10-26T19:41:47.547893Z","caller":"traceutil/trace.go:171","msg":"trace[2062270576] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:14142; }","duration":"140.890027ms","start":"2026-10-26T19:41:47.406987Z","end":"2026-10-26T19:41:47.547877Z","steps":["trace[2062270576] 'agreement among raft nodes before linearized reading'  (duration: 140.712263ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:41:47.547931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.139592ms","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-26T19:41:47.54805Z","caller":"traceutil/trace.go:171","msg":"trace[731013602] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14142; }","duration":"122.309686ms","start":"2026-10-26T19:41:47.42572Z","end":"2026-10-26T19:41:47.54803Z","steps":["trace[731013602] 'agreement among raft nodes before linearized reading'  (duration: 122.01963ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:41:47.548263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.850038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-10-26T19:41:47.54837Z","caller":"traceutil/trace.go:171","msg":"trace[505601251] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14142; }","duration":"123.022332ms","start":"2026-10-26T19:41:47.425319Z","end":"2026-10-26T19:41:47.548342Z","steps":["trace[505601251] 'agreement among raft nodes before linearized reading'  (duration: 122.415429ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:42:11.132737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.953566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12428"}
{"level":"info","ts":"2026-10-26T19:42:11.132844Z","caller":"traceutil/trace.go:171","msg":"trace[289120427] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14458; }","duration":"293.10473ms","start":"2026-10-26T19:42:10.839717Z","end":"2026-10-26T19:42:11.132821Z","steps":["trace[289120427] 'range keys from in-memory index tree'  (duration: 292.69406ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:42:11.132964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.909096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-10-26T19:42:11.133081Z","caller":"traceutil/trace.go:171","msg":"trace[819783977] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14458; }","duration":"263.09863ms","start":"2026-10-26T19:42:10.869954Z","end":"2026-10-26T19:42:11.133052Z","steps":["trace[819783977] 'range keys from in-memory index tree'  (duration: 262.6626ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:43:06.138133Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12656}
{"level":"info","ts":"2026-10-26T19:43:06.222998Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12656,"took":"82.133269ms","hash":4256044812,"current-db-size-bytes":54747136,"current-db-size":"55 MB","current-db-size-in-use-bytes":30117888,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-10-26T19:43:06.223069Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4256044812,"revision":12656,"compact-revision":10328}
{"level":"info","ts":"2026-10-26T19:48:06.145762Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15105}
{"level":"info","ts":"2026-10-26T19:48:06.248592Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15105,"took":"99.382786ms","hash":2025091451,"current-db-size-bytes":54747136,"current-db-size":"55 MB","current-db-size-in-use-bytes":32120832,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-26T19:48:06.248684Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2025091451,"revision":15105,"compact-revision":12656}
{"level":"info","ts":"2026-10-26T19:49:02.881905Z","caller":"traceutil/trace.go:171","msg":"trace[1254269667] transaction","detail":"{read_only:false; response_revision:17734; number_of_response:1; }","duration":"151.71986ms","start":"2026-10-26T19:49:02.730157Z","end":"2026-10-26T19:49:02.881877Z","steps":["trace[1254269667] 'process raft request'  (duration: 151.192218ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:49:08.39647Z","caller":"traceutil/trace.go:171","msg":"trace[1986251898] linearizableReadLoop","detail":"{readStateIndex:18370; appliedIndex:18369; }","duration":"126.831926ms","start":"2026-10-26T19:49:08.269612Z","end":"2026-10-26T19:49:08.396444Z","steps":["trace[1986251898] 'read index received'  (duration: 126.494048ms)","trace[1986251898] 'applied index is now lower than readState.Index'  (duration: 336.688µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:49:08.39655Z","caller":"traceutil/trace.go:171","msg":"trace[126741597] transaction","detail":"{read_only:false; response_revision:17765; number_of_response:1; }","duration":"201.934034ms","start":"2026-10-26T19:49:08.194574Z","end":"2026-10-26T19:49:08.396508Z","steps":["trace[126741597] 'process raft request'  (duration: 201.626707ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:49:08.396836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.203645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-k8wwd\" ","response":"range_response_count:1 size:9800"}
{"level":"info","ts":"2026-10-26T19:49:08.396961Z","caller":"traceutil/trace.go:171","msg":"trace[160454371] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-k8wwd; range_end:; response_count:1; response_revision:17765; }","duration":"127.404359ms","start":"2026-10-26T19:49:08.269532Z","end":"2026-10-26T19:49:08.396936Z","steps":["trace[160454371] 'agreement among raft nodes before linearized reading'  (duration: 127.063461ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:49:09.166376Z","caller":"traceutil/trace.go:171","msg":"trace[1197629718] transaction","detail":"{read_only:false; response_revision:17767; number_of_response:1; }","duration":"251.967585ms","start":"2026-10-26T19:49:08.914374Z","end":"2026-10-26T19:49:09.166342Z","steps":["trace[1197629718] 'process raft request'  (duration: 251.75163ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:49:09.223731Z","caller":"traceutil/trace.go:171","msg":"trace[382126878] linearizableReadLoop","detail":"{readStateIndex:18374; appliedIndex:18371; }","duration":"247.873542ms","start":"2026-10-26T19:49:08.975824Z","end":"2026-10-26T19:49:09.223697Z","steps":["trace[382126878] 'read index received'  (duration: 190.339582ms)","trace[382126878] 'applied index is now lower than readState.Index'  (duration: 57.53251ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:49:09.224174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.291873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"warn","ts":"2026-10-26T19:49:09.224236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.868922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-10-26T19:49:09.224285Z","caller":"traceutil/trace.go:171","msg":"trace[74143635] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17769; }","duration":"239.931223ms","start":"2026-10-26T19:49:08.984337Z","end":"2026-10-26T19:49:09.224269Z","steps":["trace[74143635] 'agreement among raft nodes before linearized reading'  (duration: 239.724289ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:49:09.224336Z","caller":"traceutil/trace.go:171","msg":"trace[636349842] transaction","detail":"{read_only:false; response_revision:17768; number_of_response:1; }","duration":"259.829853ms","start":"2026-10-26T19:49:08.964492Z","end":"2026-10-26T19:49:09.224322Z","steps":["trace[636349842] 'process raft request'  (duration: 239.341329ms)","trace[636349842] 'compare'  (duration: 19.663314ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:49:09.224279Z","caller":"traceutil/trace.go:171","msg":"trace[1376613597] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17769; }","duration":"248.441496ms","start":"2026-10-26T19:49:08.975816Z","end":"2026-10-26T19:49:09.224257Z","steps":["trace[1376613597] 'agreement among raft nodes before linearized reading'  (duration: 248.082317ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:49:09.224606Z","caller":"traceutil/trace.go:171","msg":"trace[1912793026] transaction","detail":"{read_only:false; response_revision:17769; number_of_response:1; }","duration":"257.135222ms","start":"2026-10-26T19:49:08.967459Z","end":"2026-10-26T19:49:09.224594Z","steps":["trace[1912793026] 'process raft request'  (duration: 256.183209ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:50:15.780785Z","caller":"traceutil/trace.go:171","msg":"trace[936580907] transaction","detail":"{read_only:false; response_revision:18550; number_of_response:1; }","duration":"155.166901ms","start":"2026-10-26T19:50:15.625542Z","end":"2026-10-26T19:50:15.780709Z","steps":["trace[936580907] 'process raft request'  (duration: 148.150054ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T19:51:54.92425Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"94bfbb0e034a3ac2","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-26T19:51:54.932507Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-10-26T19:51:54.932674Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-10-26T19:53:06.163839Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17333}
{"level":"info","ts":"2026-10-26T19:53:06.274166Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17333,"took":"105.041361ms","hash":1286323711,"current-db-size-bytes":54747136,"current-db-size":"55 MB","current-db-size-in-use-bytes":35164160,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-10-26T19:53:06.274373Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1286323711,"revision":17333,"compact-revision":15105}
{"level":"warn","ts":"2026-10-26T19:56:45.03459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.158058ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4234124143453184881 > lease_revoke:<id:3ac2a179a16ea286>","response":"size:29"}
{"level":"info","ts":"2026-10-26T19:56:45.034756Z","caller":"traceutil/trace.go:171","msg":"trace[272909037] linearizableReadLoop","detail":"{readStateIndex:22279; appliedIndex:22278; }","duration":"240.092327ms","start":"2026-10-26T19:56:44.794605Z","end":"2026-10-26T19:56:45.034697Z","steps":["trace[272909037] 'read index received'  (duration: 93.695974ms)","trace[272909037] 'applied index is now lower than readState.Index'  (duration: 146.394553ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:56:45.034864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.240122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T19:56:45.034932Z","caller":"traceutil/trace.go:171","msg":"trace[1566510958] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21557; }","duration":"240.354073ms","start":"2026-10-26T19:56:44.794561Z","end":"2026-10-26T19:56:45.034915Z","steps":["trace[1566510958] 'agreement among raft nodes before linearized reading'  (duration: 240.22227ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:56:45.461654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.615481ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4234124143453184885 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:21550 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-26T19:56:45.461782Z","caller":"traceutil/trace.go:171","msg":"trace[11588602] linearizableReadLoop","detail":"{readStateIndex:22281; appliedIndex:22280; }","duration":"311.49624ms","start":"2026-10-26T19:56:45.150265Z","end":"2026-10-26T19:56:45.461762Z","steps":["trace[11588602] 'read index received'  (duration: 144.560953ms)","trace[11588602] 'applied index is now lower than readState.Index'  (duration: 166.933327ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:56:45.462078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.804617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:573"}
{"level":"info","ts":"2026-10-26T19:56:45.462001Z","caller":"traceutil/trace.go:171","msg":"trace[613126117] transaction","detail":"{read_only:false; response_revision:21559; number_of_response:1; }","duration":"374.779058ms","start":"2026-10-26T19:56:45.08716Z","end":"2026-10-26T19:56:45.461939Z","steps":["trace[613126117] 'process raft request'  (duration: 207.744318ms)","trace[613126117] 'compare'  (duration: 166.376376ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:56:45.462235Z","caller":"traceutil/trace.go:171","msg":"trace[553898391] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:21559; }","duration":"311.901869ms","start":"2026-10-26T19:56:45.150223Z","end":"2026-10-26T19:56:45.462125Z","steps":["trace[553898391] 'agreement among raft nodes before linearized reading'  (duration: 311.593332ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:56:45.462264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:56:45.087131Z","time spent":"375.031884ms","remote":"127.0.0.1:58194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:21550 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-10-26T19:56:45.46231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:56:45.150203Z","time spent":"312.090074ms","remote":"127.0.0.1:58194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":596,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"warn","ts":"2026-10-26T19:56:45.746091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.167976ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4234124143453184887 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:21551 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-26T19:56:45.746227Z","caller":"traceutil/trace.go:171","msg":"trace[234030198] transaction","detail":"{read_only:false; response_revision:21560; number_of_response:1; }","duration":"279.718463ms","start":"2026-10-26T19:56:45.466491Z","end":"2026-10-26T19:56:45.746209Z","steps":["trace[234030198] 'process raft request'  (duration: 161.28086ms)","trace[234030198] 'compare'  (duration: 117.923771ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:56:46.011646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.730314ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4234124143453184891 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:21552 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-26T19:56:46.01178Z","caller":"traceutil/trace.go:171","msg":"trace[362921321] linearizableReadLoop","detail":"{readStateIndex:22284; appliedIndex:22283; }","duration":"217.106399ms","start":"2026-10-26T19:56:45.794651Z","end":"2026-10-26T19:56:46.011758Z","steps":["trace[362921321] 'read index received'  (duration: 77.024987ms)","trace[362921321] 'applied index is now lower than readState.Index'  (duration: 140.079462ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:56:46.011825Z","caller":"traceutil/trace.go:171","msg":"trace[1042047655] transaction","detail":"{read_only:false; response_revision:21562; number_of_response:1; }","duration":"261.250406ms","start":"2026-10-26T19:56:45.750512Z","end":"2026-10-26T19:56:46.011762Z","steps":["trace[1042047655] 'process raft request'  (duration: 121.285757ms)","trace[1042047655] 'compare'  (duration: 139.591131ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T19:56:46.012058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.349905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T19:56:46.012177Z","caller":"traceutil/trace.go:171","msg":"trace[1263914628] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21562; }","duration":"217.56123ms","start":"2026-10-26T19:56:45.79459Z","end":"2026-10-26T19:56:46.012151Z","steps":["trace[1263914628] 'agreement among raft nodes before linearized reading'  (duration: 217.297244ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T19:56:46.317929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.637153ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4234124143453184897 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:21555 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-26T19:56:46.318101Z","caller":"traceutil/trace.go:171","msg":"trace[29409977] transaction","detail":"{read_only:false; response_revision:21564; number_of_response:1; }","duration":"229.781266ms","start":"2026-10-26T19:56:46.088294Z","end":"2026-10-26T19:56:46.318075Z","steps":["trace[29409977] 'process raft request'  (duration: 100.887637ms)","trace[29409977] 'compare'  (duration: 128.50261ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T19:58:06.171805Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20023}
{"level":"info","ts":"2026-10-26T19:58:06.295361Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20023,"took":"118.829246ms","hash":3227800635,"current-db-size-bytes":54747136,"current-db-size":"55 MB","current-db-size-in-use-bytes":31416320,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-26T19:58:06.295444Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3227800635,"revision":20023,"compact-revision":17333}
{"level":"info","ts":"2026-10-26T20:00:17.869908Z","caller":"traceutil/trace.go:171","msg":"trace[426520507] linearizableReadLoop","detail":"{readStateIndex:24263; appliedIndex:24261; }","duration":"143.513634ms","start":"2026-10-26T20:00:17.726365Z","end":"2026-10-26T20:00:17.869879Z","steps":["trace[426520507] 'read index received'  (duration: 1.750529ms)","trace[426520507] 'applied index is now lower than readState.Index'  (duration: 141.761785ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T20:00:17.870101Z","caller":"traceutil/trace.go:171","msg":"trace[1381862688] transaction","detail":"{read_only:false; response_revision:23483; number_of_response:1; }","duration":"146.113173ms","start":"2026-10-26T20:00:17.723851Z","end":"2026-10-26T20:00:17.869965Z","steps":["trace[1381862688] 'process raft request'  (duration: 141.399806ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:00:17.870246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.845512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-10-26T20:00:17.870332Z","caller":"traceutil/trace.go:171","msg":"trace[1432939252] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:23483; }","duration":"143.982754ms","start":"2026-10-26T20:00:17.726328Z","end":"2026-10-26T20:00:17.870311Z","steps":["trace[1432939252] 'agreement among raft nodes before linearized reading'  (duration: 143.677518ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:00:31.525378Z","caller":"traceutil/trace.go:171","msg":"trace[519580271] transaction","detail":"{read_only:false; response_revision:24069; number_of_response:1; }","duration":"101.524384ms","start":"2026-10-26T20:00:31.423818Z","end":"2026-10-26T20:00:31.525342Z","steps":["trace[519580271] 'process raft request'  (duration: 89.822839ms)","trace[519580271] 'compare'  (duration: 11.521881ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T20:01:50.315878Z","caller":"traceutil/trace.go:171","msg":"trace[1587176448] transaction","detail":"{read_only:false; response_revision:24923; number_of_response:1; }","duration":"119.540612ms","start":"2026-10-26T20:01:50.196311Z","end":"2026-10-26T20:01:50.315851Z","steps":["trace[1587176448] 'process raft request'  (duration: 27.792648ms)","trace[1587176448] 'compare'  (duration: 91.283314ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T20:02:38.216668Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000664b.wal"}
{"level":"info","ts":"2026-10-26T20:03:06.179551Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22265}
{"level":"info","ts":"2026-10-26T20:03:06.296211Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22265,"took":"110.443285ms","hash":1628348392,"current-db-size-bytes":55590912,"current-db-size":"56 MB","current-db-size-in-use-bytes":46018560,"current-db-size-in-use":"46 MB"}
{"level":"info","ts":"2026-10-26T20:03:06.296276Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1628348392,"revision":22265,"compact-revision":20023}
{"level":"info","ts":"2026-10-26T20:03:44.843591Z","caller":"traceutil/trace.go:171","msg":"trace[117225527] linearizableReadLoop","detail":"{readStateIndex:26821; appliedIndex:26820; }","duration":"172.988699ms","start":"2026-10-26T20:03:44.670567Z","end":"2026-10-26T20:03:44.843555Z","steps":["trace[117225527] 'read index received'  (duration: 172.737573ms)","trace[117225527] 'applied index is now lower than readState.Index'  (duration: 249.656µs)"],"step_count":2}
{"level":"info","ts":"2026-10-26T20:03:44.843663Z","caller":"traceutil/trace.go:171","msg":"trace[2097752294] transaction","detail":"{read_only:false; response_revision:25979; number_of_response:1; }","duration":"264.99655ms","start":"2026-10-26T20:03:44.578617Z","end":"2026-10-26T20:03:44.843613Z","steps":["trace[2097752294] 'process raft request'  (duration: 264.713412ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:03:44.843882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.274586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T20:03:44.844182Z","caller":"traceutil/trace.go:171","msg":"trace[3083623] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:25979; }","duration":"173.599393ms","start":"2026-10-26T20:03:44.670545Z","end":"2026-10-26T20:03:44.844145Z","steps":["trace[3083623] 'agreement among raft nodes before linearized reading'  (duration: 173.190554ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:03:45.00393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.026055ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4234124143453196904 > lease_revoke:<id:3ac2a179a16ed0ad>","response":"size:29"}
{"level":"info","ts":"2026-10-26T20:03:45.004212Z","caller":"traceutil/trace.go:171","msg":"trace[463920135] linearizableReadLoop","detail":"{readStateIndex:26822; appliedIndex:26821; }","duration":"160.491196ms","start":"2026-10-26T20:03:44.843697Z","end":"2026-10-26T20:03:45.004188Z","steps":["trace[463920135] 'read index received'  (duration: 20.192276ms)","trace[463920135] 'applied index is now lower than readState.Index'  (duration: 140.29783ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T20:03:45.004335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.28108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T20:03:45.004372Z","caller":"traceutil/trace.go:171","msg":"trace[1994677756] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25979; }","duration":"209.326531ms","start":"2026-10-26T20:03:44.795033Z","end":"2026-10-26T20:03:45.00436Z","steps":["trace[1994677756] 'agreement among raft nodes before linearized reading'  (duration: 209.25977ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:03:45.004555Z","caller":"traceutil/trace.go:171","msg":"trace[1332597867] transaction","detail":"{read_only:false; response_revision:25980; number_of_response:1; }","duration":"151.626647ms","start":"2026-10-26T20:03:44.852893Z","end":"2026-10-26T20:03:45.00452Z","steps":["trace[1332597867] 'process raft request'  (duration: 151.187757ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:03:45.366766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.830048ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4234124143453196911 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25963 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-26T20:03:45.367038Z","caller":"traceutil/trace.go:171","msg":"trace[1048100679] transaction","detail":"{read_only:false; response_revision:25983; number_of_response:1; }","duration":"345.336314ms","start":"2026-10-26T20:03:45.021679Z","end":"2026-10-26T20:03:45.367016Z","steps":["trace[1048100679] 'process raft request'  (duration: 345.186101ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:03:45.36714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:03:45.021651Z","time spent":"345.437977ms","remote":"127.0.0.1:58194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:25961 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-26T20:03:45.367281Z","caller":"traceutil/trace.go:171","msg":"trace[1482219263] transaction","detail":"{read_only:false; response_revision:25982; number_of_response:1; }","duration":"345.626271ms","start":"2026-10-26T20:03:45.021623Z","end":"2026-10-26T20:03:45.36725Z","steps":["trace[1482219263] 'process raft request'  (duration: 148.233111ms)","trace[1482219263] 'compare'  (duration: 196.725035ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T20:03:45.367466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:03:45.021598Z","time spent":"345.749464ms","remote":"127.0.0.1:58194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:25963 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-10-26T20:03:45.468296Z","caller":"traceutil/trace.go:171","msg":"trace[1318201961] linearizableReadLoop","detail":"{readStateIndex:26828; appliedIndex:26826; }","duration":"101.789791ms","start":"2026-10-26T20:03:45.366483Z","end":"2026-10-26T20:03:45.468273Z","steps":["trace[1318201961] 'read index received'  (duration: 100.455441ms)","trace[1318201961] 'applied index is now lower than readState.Index'  (duration: 1.33342ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T20:03:45.468449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.937784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/keypairs/\" range_end:\"/registry/openstack.k-orc.cloud/keypairs0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T20:03:45.468434Z","caller":"traceutil/trace.go:171","msg":"trace[1376591952] transaction","detail":"{read_only:false; response_revision:25984; number_of_response:1; }","duration":"354.39434ms","start":"2026-10-26T20:03:45.113995Z","end":"2026-10-26T20:03:45.46839Z","steps":["trace[1376591952] 'process raft request'  (duration: 353.021408ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:03:45.46849Z","caller":"traceutil/trace.go:171","msg":"trace[1810040190] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/keypairs/; range_end:/registry/openstack.k-orc.cloud/keypairs0; response_count:0; response_revision:25985; }","duration":"102.001246ms","start":"2026-10-26T20:03:45.366476Z","end":"2026-10-26T20:03:45.468478Z","steps":["trace[1810040190] 'agreement among raft nodes before linearized reading'  (duration: 101.890123ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:03:45.468499Z","caller":"traceutil/trace.go:171","msg":"trace[1321566679] transaction","detail":"{read_only:false; response_revision:25985; number_of_response:1; }","duration":"329.540458ms","start":"2026-10-26T20:03:45.1389Z","end":"2026-10-26T20:03:45.46844Z","steps":["trace[1321566679] 'process raft request'  (duration: 329.330493ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:03:45.468656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:03:45.113943Z","time spent":"354.572594ms","remote":"127.0.0.1:58194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:25902 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-10-26T20:03:45.468819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:03:45.138859Z","time spent":"329.881726ms","remote":"127.0.0.1:58194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:25964 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-10-26T20:04:50.261092Z","caller":"traceutil/trace.go:171","msg":"trace[461442181] transaction","detail":"{read_only:false; response_revision:26556; number_of_response:1; }","duration":"113.519375ms","start":"2026-10-26T20:04:50.147549Z","end":"2026-10-26T20:04:50.261069Z","steps":["trace[461442181] 'process raft request'  (duration: 113.341791ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:04:50.27275Z","caller":"traceutil/trace.go:171","msg":"trace[1026001364] transaction","detail":"{read_only:false; response_revision:26557; number_of_response:1; }","duration":"115.955891ms","start":"2026-10-26T20:04:50.15676Z","end":"2026-10-26T20:04:50.272716Z","steps":["trace[1026001364] 'process raft request'  (duration: 114.416126ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:04:55.733278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.700322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T20:04:55.733373Z","caller":"traceutil/trace.go:171","msg":"trace[179710955] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:26597; }","duration":"118.856207ms","start":"2026-10-26T20:04:55.614497Z","end":"2026-10-26T20:04:55.733353Z","steps":["trace[179710955] 'count revisions from in-memory index tree'  (duration: 118.57952ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:04:56.205275Z","caller":"traceutil/trace.go:171","msg":"trace[1776245930] linearizableReadLoop","detail":"{readStateIndex:27458; appliedIndex:27456; }","duration":"388.295575ms","start":"2026-10-26T20:04:55.816927Z","end":"2026-10-26T20:04:56.205223Z","steps":["trace[1776245930] 'read index received'  (duration: 13.532166ms)","trace[1776245930] 'applied index is now lower than readState.Index'  (duration: 374.762329ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T20:04:56.205515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.54198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T20:04:56.205599Z","caller":"traceutil/trace.go:171","msg":"trace[36912492] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:26600; }","duration":"388.656383ms","start":"2026-10-26T20:04:55.81689Z","end":"2026-10-26T20:04:56.205546Z","steps":["trace[36912492] 'agreement among raft nodes before linearized reading'  (duration: 388.53426ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:04:56.205642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:04:55.816874Z","time spent":"388.755346ms","remote":"127.0.0.1:49266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "}
{"level":"warn","ts":"2026-10-26T20:04:56.205754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.104437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-26T20:04:56.205841Z","caller":"traceutil/trace.go:171","msg":"trace[1412606905] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:26600; }","duration":"348.381874ms","start":"2026-10-26T20:04:55.857435Z","end":"2026-10-26T20:04:56.205816Z","steps":["trace[1412606905] 'agreement among raft nodes before linearized reading'  (duration: 348.062156ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:04:56.205888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:04:55.857414Z","time spent":"348.462847ms","remote":"127.0.0.1:49374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}
{"level":"info","ts":"2026-10-26T20:04:56.20589Z","caller":"traceutil/trace.go:171","msg":"trace[1963028931] transaction","detail":"{read_only:false; response_revision:26600; number_of_response:1; }","duration":"405.159217ms","start":"2026-10-26T20:04:55.800687Z","end":"2026-10-26T20:04:56.205846Z","steps":["trace[1963028931] 'process raft request'  (duration: 404.386759ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:04:56.206001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.888485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-26T20:04:56.206058Z","caller":"traceutil/trace.go:171","msg":"trace[104765126] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:26600; }","duration":"214.103249ms","start":"2026-10-26T20:04:55.991941Z","end":"2026-10-26T20:04:56.206044Z","steps":["trace[104765126] 'agreement among raft nodes before linearized reading'  (duration: 213.928875ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-26T20:04:56.206098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:04:55.800665Z","time spent":"405.328981ms","remote":"127.0.0.1:58194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26585 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-10-26T20:04:56.206218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.860592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"}
{"level":"info","ts":"2026-10-26T20:04:56.206299Z","caller":"traceutil/trace.go:171","msg":"trace[1096013182] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:26600; }","duration":"297.988145ms","start":"2026-10-26T20:04:55.908268Z","end":"2026-10-26T20:04:56.206256Z","steps":["trace[1096013182] 'agreement among raft nodes before linearized reading'  (duration: 297.653047ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:04:56.493982Z","caller":"traceutil/trace.go:171","msg":"trace[1903407032] transaction","detail":"{read_only:false; response_revision:26603; number_of_response:1; }","duration":"159.776381ms","start":"2026-10-26T20:04:56.334157Z","end":"2026-10-26T20:04:56.493933Z","steps":["trace[1903407032] 'process raft request'  (duration: 158.089584ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:04:56.710391Z","caller":"traceutil/trace.go:171","msg":"trace[767945731] linearizableReadLoop","detail":"{readStateIndex:27462; appliedIndex:27461; }","duration":"122.507709ms","start":"2026-10-26T20:04:56.587857Z","end":"2026-10-26T20:04:56.710365Z","steps":["trace[767945731] 'read index received'  (duration: 56.471926ms)","trace[767945731] 'applied index is now lower than readState.Index'  (duration: 66.034793ms)"],"step_count":2}
{"level":"info","ts":"2026-10-26T20:04:56.710462Z","caller":"traceutil/trace.go:171","msg":"trace[1785878960] transaction","detail":"{read_only:false; response_revision:26604; number_of_response:1; }","duration":"191.060947ms","start":"2026-10-26T20:04:56.519363Z","end":"2026-10-26T20:04:56.710424Z","steps":["trace[1785878960] 'process raft request'  (duration: 125.051295ms)","trace[1785878960] 'compare'  (duration: 65.831308ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-26T20:04:56.710607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.724184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:574"}
{"level":"info","ts":"2026-10-26T20:04:56.710649Z","caller":"traceutil/trace.go:171","msg":"trace[2069581514] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:26604; }","duration":"122.823156ms","start":"2026-10-26T20:04:56.587815Z","end":"2026-10-26T20:04:56.710638Z","steps":["trace[2069581514] 'agreement among raft nodes before linearized reading'  (duration: 122.655442ms)"],"step_count":1}
{"level":"info","ts":"2026-10-26T20:08:06.188802Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25609}
{"level":"info","ts":"2026-10-26T20:08:06.35763Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25609,"took":"163.676068ms","hash":1473201101,"current-db-size-bytes":58601472,"current-db-size":"59 MB","current-db-size-in-use-bytes":37236736,"current-db-size-in-use":"37 MB"}
{"level":"info","ts":"2026-10-26T20:08:06.357705Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1473201101,"revision":25609,"compact-revision":22265}
{"level":"info","ts":"2026-10-26T20:08:56.835013Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"94bfbb0e034a3ac2","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-26T20:08:56.842142Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-10-26T20:08:56.842333Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-10-26T20:13:06.1956Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28595}
{"level":"info","ts":"2026-10-26T20:13:06.343581Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28595,"took":"144.562667ms","hash":1048477275,"current-db-size-bytes":58601472,"current-db-size":"59 MB","current-db-size-in-use-bytes":33476608,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-10-26T20:13:06.343654Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1048477275,"revision":28595,"compact-revision":25609}
{"level":"info","ts":"2026-10-26T20:18:06.20301Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30991}
{"level":"info","ts":"2026-10-26T20:18:06.353766Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30991,"took":"138.279589ms","hash":775358914,"current-db-size-bytes":58601472,"current-db-size":"59 MB","current-db-size-in-use-bytes":31354880,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-26T20:18:06.353851Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":775358914,"revision":30991,"compact-revision":28595}
{"level":"info","ts":"2026-10-26T20:23:06.209681Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33286}
{"level":"info","ts":"2026-10-26T20:23:06.370013Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33286,"took":"154.981156ms","hash":3509182953,"current-db-size-bytes":59645952,"current-db-size":"60 MB","current-db-size-in-use-bytes":31129600,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-26T20:23:06.370075Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3509182953,"revision":33286,"compact-revision":30991}
{"level":"info","ts":"2026-10-26T20:28:06.219987Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35549}
{"level":"info","ts":"2026-10-26T20:28:06.371763Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35549,"took":"147.321683ms","hash":29799681,"current-db-size-bytes":59645952,"current-db-size":"60 MB","current-db-size-in-use-bytes":32702464,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-10-26T20:28:06.371848Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":29799681,"revision":35549,"compact-revision":33286}
{"level":"info","ts":"2026-10-26T20:30:02.372183Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"94bfbb0e034a3ac2","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-26T20:30:02.379464Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-10-26T20:30:02.37956Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-10-26T20:33:06.22925Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37883}
{"level":"info","ts":"2026-10-26T20:33:06.384278Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37883,"took":"150.260109ms","hash":3848263086,"current-db-size-bytes":59645952,"current-db-size":"60 MB","current-db-size-in-use-bytes":32583680,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-10-26T20:33:06.384349Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3848263086,"revision":37883,"compact-revision":35549}
{"level":"info","ts":"2026-10-26T20:38:06.236415Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":40200}
{"level":"info","ts":"2026-10-26T20:38:06.371036Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":40200,"took":"129.490261ms","hash":812488003,"current-db-size-bytes":59645952,"current-db-size":"60 MB","current-db-size-in-use-bytes":31428608,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-26T20:38:06.371103Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":812488003,"revision":40200,"compact-revision":37883}