{"level":"warn","ts":"2026-09-10T01:58:07.140495Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-10T01:58:07.140656Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.5: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.5:2380","--initial-cluster=instance=https://162.253.55.5:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.5:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.5:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-09-10T01:58:07.140739Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-10T01:58:07.140755Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.5:2380"]}
{"level":"info","ts":"2026-09-10T01:58:07.140794Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-09-10T01:58:07.14151Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.5:2379"]}
{"level":"info","ts":"2026-09-10T01:58:07.141609Z","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.5:2380"],"listen-peer-urls":["https://162.253.55.5:2380"],"advertise-client-urls":["https://162.253.55.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.5:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-09-10T01:58:07.145824Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.884146ms"}
{"level":"info","ts":"2026-09-10T01:58:07.152305Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b512f7d8ac93be25","cluster-id":"e1953d9a3e7368e5"}
{"level":"info","ts":"2026-09-10T01:58:07.152388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 switched to configuration voters=()"}
{"level":"info","ts":"2026-09-10T01:58:07.152408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became follower at term 0"}
{"level":"info","ts":"2026-09-10T01:58:07.152427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b512f7d8ac93be25 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-10T01:58:07.152437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became follower at term 1"}
{"level":"info","ts":"2026-09-10T01:58:07.152477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 switched to configuration voters=(13047763580426108453)"}
{"level":"warn","ts":"2026-09-10T01:58:07.158792Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-10T01:58:07.16189Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-10T01:58:07.1637Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-09-10T01:58:07.16767Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b512f7d8ac93be25","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-10T01:58:07.167877Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b512f7d8ac93be25","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-10T01:58:07.16804Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-09-10T01:58:07.16813Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-09-10T01:58:07.168145Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-09-10T01:58:07.169142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 switched to configuration voters=(13047763580426108453)"}
{"level":"info","ts":"2026-09-10T01:58:07.169409Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e1953d9a3e7368e5","local-member-id":"b512f7d8ac93be25","added-peer-id":"b512f7d8ac93be25","added-peer-peer-urls":["https://162.253.55.5:2380"]}
{"level":"info","ts":"2026-09-10T01:58:07.172753Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-09-10T01:58:07.172838Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.5:2380"}
{"level":"info","ts":"2026-09-10T01:58:07.172909Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.5:2380"}
{"level":"info","ts":"2026-09-10T01:58:07.173148Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b512f7d8ac93be25","initial-advertise-peer-urls":["https://162.253.55.5:2380"],"listen-peer-urls":["https://162.253.55.5:2380"],"advertise-client-urls":["https://162.253.55.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-10T01:58:07.173226Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-10T01:58:07.353327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 is starting a new election at term 1"}
{"level":"info","ts":"2026-09-10T01:58:07.353477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-10T01:58:07.353511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 received MsgPreVoteResp from b512f7d8ac93be25 at term 1"}
{"level":"info","ts":"2026-09-10T01:58:07.353531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became candidate at term 2"}
{"level":"info","ts":"2026-09-10T01:58:07.35361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 received MsgVoteResp from b512f7d8ac93be25 at term 2"}
{"level":"info","ts":"2026-09-10T01:58:07.353716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b512f7d8ac93be25 became leader at term 2"}
{"level":"info","ts":"2026-09-10T01:58:07.353807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b512f7d8ac93be25 elected leader b512f7d8ac93be25 at term 2"}
{"level":"info","ts":"2026-09-10T01:58:07.355118Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-10T01:58:07.356237Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-10T01:58:07.356223Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b512f7d8ac93be25","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.5:2379]}","request-path":"/0/members/b512f7d8ac93be25/attributes","cluster-id":"e1953d9a3e7368e5","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-10T01:58:07.356329Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-10T01:58:07.356697Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-10T01:58:07.35674Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e1953d9a3e7368e5","local-member-id":"b512f7d8ac93be25","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-10T01:58:07.356796Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-10T01:58:07.357053Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-10T01:58:07.357154Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-10T01:58:07.36049Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-09-10T01:58:07.36086Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.5:2379"}
{"level":"info","ts":"2026-09-10T01:58:59.324799Z","caller":"traceutil/trace.go:171","msg":"trace[597795041] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"189.685094ms","start":"2026-09-10T01:58:59.135085Z","end":"2026-09-10T01:58:59.324771Z","steps":["trace[597795041] 'process raft request'  (duration: 189.53714ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T01:58:59.373211Z","caller":"traceutil/trace.go:171","msg":"trace[1399920155] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"228.231466ms","start":"2026-09-10T01:58:59.144922Z","end":"2026-09-10T01:58:59.373153Z","steps":["trace[1399920155] 'process raft request'  (duration: 227.878546ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T01:58:59.373242Z","caller":"traceutil/trace.go:171","msg":"trace[475833464] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"221.284306ms","start":"2026-09-10T01:58:59.151907Z","end":"2026-09-10T01:58:59.373191Z","steps":["trace[475833464] 'process raft request'  (duration: 221.08613ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T01:58:59.373292Z","caller":"traceutil/trace.go:171","msg":"trace[234017755] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"216.462345ms","start":"2026-09-10T01:58:59.156791Z","end":"2026-09-10T01:58:59.373254Z","steps":["trace[234017755] 'process raft request'  (duration: 216.257478ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T01:58:59.37352Z","caller":"traceutil/trace.go:171","msg":"trace[801704152] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"225.890883ms","start":"2026-09-10T01:58:59.147604Z","end":"2026-09-10T01:58:59.373495Z","steps":["trace[801704152] 'process raft request'  (duration: 225.334907ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T01:58:59.373555Z","caller":"traceutil/trace.go:171","msg":"trace[538419511] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"213.068452ms","start":"2026-09-10T01:58:59.160463Z","end":"2026-09-10T01:58:59.373531Z","steps":["trace[538419511] 'process raft request'  (duration: 212.716163ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T01:58:59.373521Z","caller":"traceutil/trace.go:171","msg":"trace[1161671883] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"214.42977ms","start":"2026-09-10T01:58:59.159031Z","end":"2026-09-10T01:58:59.373461Z","steps":["trace[1161671883] 'process raft request'  (duration: 214.095321ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T01:58:59.373718Z","caller":"traceutil/trace.go:171","msg":"trace[1470753212] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"207.221273ms","start":"2026-09-10T01:58:59.166478Z","end":"2026-09-10T01:58:59.373699Z","steps":["trace[1470753212] 'process raft request'  (duration: 206.764431ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T01:58:59.374172Z","caller":"traceutil/trace.go:171","msg":"trace[547822759] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"199.351788ms","start":"2026-09-10T01:58:59.1748Z","end":"2026-09-10T01:58:59.374152Z","steps":["trace[547822759] 'process raft request'  (duration: 199.03167ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T01:58:59.375037Z","caller":"traceutil/trace.go:171","msg":"trace[1616277143] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"177.756548ms","start":"2026-09-10T01:58:59.197257Z","end":"2026-09-10T01:58:59.375013Z","steps":["trace[1616277143] 'process raft request'  (duration: 177.686227ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T01:58:59.375047Z","caller":"traceutil/trace.go:171","msg":"trace[249164887] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"193.876209ms","start":"2026-09-10T01:58:59.18115Z","end":"2026-09-10T01:58:59.375026Z","steps":["trace[249164887] 'process raft request'  (duration: 193.673793ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T01:59:06.513699Z","caller":"traceutil/trace.go:171","msg":"trace[1210891379] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"414.106825ms","start":"2026-09-10T01:59:06.099571Z","end":"2026-09-10T01:59:06.513677Z","steps":["trace[1210891379] 'process raft request'  (duration: 413.412286ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T01:59:06.513867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.090822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-09-10T01:59:06.513973Z","caller":"traceutil/trace.go:171","msg":"trace[1153800819] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:665; }","duration":"379.262566ms","start":"2026-09-10T01:59:06.134694Z","end":"2026-09-10T01:59:06.513957Z","steps":["trace[1153800819] 'agreement among raft nodes before linearized reading'  (duration: 379.044979ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T01:59:06.514022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:59:06.134667Z","time spent":"379.343439ms","remote":"127.0.0.1:60636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-09-10T01:59:06.513679Z","caller":"traceutil/trace.go:171","msg":"trace[1179489098] linearizableReadLoop","detail":"{readStateIndex:693; appliedIndex:692; }","duration":"378.866564ms","start":"2026-09-10T01:59:06.134753Z","end":"2026-09-10T01:59:06.51362Z","steps":["trace[1179489098] 'read index received'  (duration: 378.109994ms)","trace[1179489098] 'applied index is now lower than readState.Index'  (duration: 755.71µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T01:59:06.514426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:59:06.099538Z","time spent":"414.233018ms","remote":"127.0.0.1:60458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:658 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036201 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-09-10T01:59:06.635505Z","caller":"traceutil/trace.go:171","msg":"trace[193947101] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"115.823549ms","start":"2026-09-10T01:59:06.519655Z","end":"2026-09-10T01:59:06.635478Z","steps":["trace[193947101] 'process raft request'  (duration: 93.107689ms)","trace[193947101] 'compare'  (duration: 22.562796ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T01:59:06.988962Z","caller":"traceutil/trace.go:171","msg":"trace[1098760318] linearizableReadLoop","detail":"{readStateIndex:697; appliedIndex:696; }","duration":"116.153878ms","start":"2026-09-10T01:59:06.872777Z","end":"2026-09-10T01:59:06.988931Z","steps":["trace[1098760318] 'read index received'  (duration: 59.604466ms)","trace[1098760318] 'applied index is now lower than readState.Index'  (duration: 56.547702ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T01:59:06.989204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.405955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-09-10T01:59:06.989236Z","caller":"traceutil/trace.go:171","msg":"trace[1026020655] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:668; }","duration":"116.513408ms","start":"2026-09-10T01:59:06.872712Z","end":"2026-09-10T01:59:06.989226Z","steps":["trace[1026020655] 'agreement among raft nodes before linearized reading'  (duration: 116.324573ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T01:59:07.698531Z","caller":"traceutil/trace.go:171","msg":"trace[638186704] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"569.088944ms","start":"2026-09-10T01:59:07.129412Z","end":"2026-09-10T01:59:07.698501Z","steps":["trace[638186704] 'process raft request'  (duration: 568.414106ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T01:59:07.698799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:59:07.129375Z","time spent":"569.32868ms","remote":"127.0.0.1:60458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:665 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036225 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-09-10T01:59:26.08111Z","caller":"traceutil/trace.go:171","msg":"trace[239294812] linearizableReadLoop","detail":"{readStateIndex:875; appliedIndex:874; }","duration":"103.869173ms","start":"2026-09-10T01:59:25.97721Z","end":"2026-09-10T01:59:26.081079Z","steps":["trace[239294812] 'read index received'  (duration: 103.650757ms)","trace[239294812] 'applied index is now lower than readState.Index'  (duration: 217.126µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T01:59:26.081157Z","caller":"traceutil/trace.go:171","msg":"trace[1572440662] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"333.63413ms","start":"2026-09-10T01:59:25.747498Z","end":"2026-09-10T01:59:26.081133Z","steps":["trace[1572440662] 'process raft request'  (duration: 333.397534ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T01:59:26.081363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T01:59:25.747477Z","time spent":"333.737964ms","remote":"127.0.0.1:60548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4023,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-vgvhp\" mod_revision:797 > success:<request_put:<key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-vgvhp\" value_size:3939 >> failure:<request_range:<key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-vgvhp\" > >"}
{"level":"warn","ts":"2026-09-10T01:59:26.081427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.206872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-09-10T01:59:26.08147Z","caller":"traceutil/trace.go:171","msg":"trace[637437079] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:841; }","duration":"104.291954ms","start":"2026-09-10T01:59:25.977166Z","end":"2026-09-10T01:59:26.081458Z","steps":["trace[637437079] 'agreement among raft nodes before linearized reading'  (duration: 104.088629ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T01:59:56.454759Z","caller":"traceutil/trace.go:171","msg":"trace[2128702929] linearizableReadLoop","detail":"{readStateIndex:1281; appliedIndex:1280; }","duration":"156.898556ms","start":"2026-09-10T01:59:56.297827Z","end":"2026-09-10T01:59:56.454726Z","steps":["trace[2128702929] 'read index received'  (duration: 137.105626ms)","trace[2128702929] 'applied index is now lower than readState.Index'  (duration: 19.79143ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T01:59:56.455182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.344711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-09-10T01:59:56.455135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.280407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-09-10T01:59:56.45525Z","caller":"traceutil/trace.go:171","msg":"trace[478432539] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1240; }","duration":"156.501166ms","start":"2026-09-10T01:59:56.298733Z","end":"2026-09-10T01:59:56.455235Z","steps":["trace[478432539] 'agreement among raft nodes before linearized reading'  (duration: 156.184577ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T01:59:56.455281Z","caller":"traceutil/trace.go:171","msg":"trace[970059296] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1240; }","duration":"157.494172ms","start":"2026-09-10T01:59:56.297763Z","end":"2026-09-10T01:59:56.455257Z","steps":["trace[970059296] 'agreement among raft nodes before linearized reading'  (duration: 157.122782ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:00:45.715598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.086716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-09-10T02:00:45.715777Z","caller":"traceutil/trace.go:171","msg":"trace[242366663] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1912; }","duration":"338.396004ms","start":"2026-09-10T02:00:45.377343Z","end":"2026-09-10T02:00:45.715739Z","steps":["trace[242366663] 'range keys from in-memory index tree'  (duration: 337.754607ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:00:45.71584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:00:45.377318Z","time spent":"338.504708ms","remote":"127.0.0.1:38980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5468,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"info","ts":"2026-09-10T02:00:45.715848Z","caller":"traceutil/trace.go:171","msg":"trace[796667495] linearizableReadLoop","detail":"{readStateIndex:1990; appliedIndex:1989; }","duration":"118.738646ms","start":"2026-09-10T02:00:45.597093Z","end":"2026-09-10T02:00:45.715832Z","steps":["trace[796667495] 'read index received'  (duration: 101.402585ms)","trace[796667495] 'applied index is now lower than readState.Index'  (duration: 17.334921ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:00:45.715958Z","caller":"traceutil/trace.go:171","msg":"trace[1150926566] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"230.330714ms","start":"2026-09-10T02:00:45.485593Z","end":"2026-09-10T02:00:45.715924Z","steps":["trace[1150926566] 'process raft request'  (duration: 212.960942ms)","trace[1150926566] 'compare'  (duration: 17.083585ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T02:00:45.716034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.096165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-30af13a7-30b5-4896-8834-81fb9d663cee\" ","response":"range_response_count:1 size:3742"}
{"level":"info","ts":"2026-09-10T02:00:45.71607Z","caller":"traceutil/trace.go:171","msg":"trace[107449814] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-30af13a7-30b5-4896-8834-81fb9d663cee; range_end:; response_count:1; response_revision:1913; }","duration":"115.168627ms","start":"2026-09-10T02:00:45.600888Z","end":"2026-09-10T02:00:45.716057Z","steps":["trace[107449814] 'agreement among raft nodes before linearized reading'  (duration: 115.044774ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:00:45.716122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.006414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-09-10T02:00:45.716195Z","caller":"traceutil/trace.go:171","msg":"trace[45332770] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1913; }","duration":"119.157487ms","start":"2026-09-10T02:00:45.597021Z","end":"2026-09-10T02:00:45.716178Z","steps":["trace[45332770] 'agreement among raft nodes before linearized reading'  (duration: 118.89721ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:00:46.187358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.336354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-09-10T02:00:46.187481Z","caller":"traceutil/trace.go:171","msg":"trace[316534120] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1915; }","duration":"213.513089ms","start":"2026-09-10T02:00:45.973944Z","end":"2026-09-10T02:00:46.187457Z","steps":["trace[316534120] 'range keys from in-memory index tree'  (duration: 213.120548ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:00:55.016849Z","caller":"traceutil/trace.go:171","msg":"trace[1437725999] transaction","detail":"{read_only:false; response_revision:2004; number_of_response:1; }","duration":"171.885592ms","start":"2026-09-10T02:00:54.844923Z","end":"2026-09-10T02:00:55.016809Z","steps":["trace[1437725999] 'process raft request'  (duration: 148.595685ms)","trace[1437725999] 'compare'  (duration: 23.088451ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:00:59.95085Z","caller":"traceutil/trace.go:171","msg":"trace[1728229910] transaction","detail":"{read_only:false; response_revision:2036; number_of_response:1; }","duration":"196.879716ms","start":"2026-09-10T02:00:59.75393Z","end":"2026-09-10T02:00:59.95081Z","steps":["trace[1728229910] 'process raft request'  (duration: 196.63134ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:00:59.987021Z","caller":"traceutil/trace.go:171","msg":"trace[2633165] transaction","detail":"{read_only:false; response_revision:2037; number_of_response:1; }","duration":"231.780565ms","start":"2026-09-10T02:00:59.755196Z","end":"2026-09-10T02:00:59.986977Z","steps":["trace[2633165] 'process raft request'  (duration: 231.514606ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:00:59.987366Z","caller":"traceutil/trace.go:171","msg":"trace[1476428021] transaction","detail":"{read_only:false; response_revision:2038; number_of_response:1; }","duration":"229.386328ms","start":"2026-09-10T02:00:59.757939Z","end":"2026-09-10T02:00:59.987325Z","steps":["trace[1476428021] 'process raft request'  (duration: 228.959006ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:00:59.988017Z","caller":"traceutil/trace.go:171","msg":"trace[769271634] linearizableReadLoop","detail":"{readStateIndex:2120; appliedIndex:2116; }","duration":"159.905559ms","start":"2026-09-10T02:00:59.828079Z","end":"2026-09-10T02:00:59.987985Z","steps":["trace[769271634] 'read index received'  (duration: 122.563243ms)","trace[769271634] 'applied index is now lower than readState.Index'  (duration: 37.340756ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:00:59.988184Z","caller":"traceutil/trace.go:171","msg":"trace[1264813470] transaction","detail":"{read_only:false; response_revision:2039; number_of_response:1; }","duration":"223.881455ms","start":"2026-09-10T02:00:59.764286Z","end":"2026-09-10T02:00:59.988168Z","steps":["trace[1264813470] 'process raft request'  (duration: 223.561256ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:00:59.988326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.217738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-09-10T02:00:59.988391Z","caller":"traceutil/trace.go:171","msg":"trace[469408971] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2039; }","duration":"160.287379ms","start":"2026-09-10T02:00:59.82807Z","end":"2026-09-10T02:00:59.988357Z","steps":["trace[469408971] 'agreement among raft nodes before linearized reading'  (duration: 160.101644ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:00:59.98866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.371912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-09-10T02:00:59.988708Z","caller":"traceutil/trace.go:171","msg":"trace[316484413] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2039; }","duration":"129.482925ms","start":"2026-09-10T02:00:59.859214Z","end":"2026-09-10T02:00:59.988697Z","steps":["trace[316484413] 'agreement among raft nodes before linearized reading'  (duration: 129.29544ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:01:31.52964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.977595ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13701533951772607045 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:3e25a089095c4244>","response":"size:41"}
{"level":"info","ts":"2026-09-10T02:01:31.530477Z","caller":"traceutil/trace.go:171","msg":"trace[873396271] transaction","detail":"{read_only:false; response_revision:2219; number_of_response:1; }","duration":"236.569978ms","start":"2026-09-10T02:01:31.293881Z","end":"2026-09-10T02:01:31.530451Z","steps":["trace[873396271] 'process raft request'  (duration: 236.187217ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:01:37.20577Z","caller":"traceutil/trace.go:171","msg":"trace[209032476] transaction","detail":"{read_only:false; response_revision:2248; number_of_response:1; }","duration":"226.311932ms","start":"2026-09-10T02:01:36.979428Z","end":"2026-09-10T02:01:37.20574Z","steps":["trace[209032476] 'process raft request'  (duration: 226.125647ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:02:30.091021Z","caller":"traceutil/trace.go:171","msg":"trace[580778587] transaction","detail":"{read_only:false; response_revision:2710; number_of_response:1; }","duration":"164.031672ms","start":"2026-09-10T02:02:29.92695Z","end":"2026-09-10T02:02:30.090982Z","steps":["trace[580778587] 'process raft request'  (duration: 163.742604ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:03:05.665264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.869744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/auth-system/keycloak\" ","response":"range_response_count:1 size:7462"}
{"level":"info","ts":"2026-09-10T02:03:05.665353Z","caller":"traceutil/trace.go:171","msg":"trace[1779138318] range","detail":"{range_begin:/registry/statefulsets/auth-system/keycloak; range_end:; response_count:1; response_revision:2921; }","duration":"282.003967ms","start":"2026-09-10T02:03:05.38333Z","end":"2026-09-10T02:03:05.665334Z","steps":["trace[1779138318] 'range keys from in-memory index tree'  (duration: 281.639488ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:03:05.680871Z","caller":"traceutil/trace.go:171","msg":"trace[807660939] transaction","detail":"{read_only:false; response_revision:2922; number_of_response:1; }","duration":"133.527774ms","start":"2026-09-10T02:03:05.547319Z","end":"2026-09-10T02:03:05.680847Z","steps":["trace[807660939] 'process raft request'  (duration: 133.38812ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:05:54.428449Z","caller":"traceutil/trace.go:171","msg":"trace[858595510] transaction","detail":"{read_only:false; response_revision:3938; number_of_response:1; }","duration":"142.326221ms","start":"2026-09-10T02:05:54.286083Z","end":"2026-09-10T02:05:54.42841Z","steps":["trace[858595510] 'process raft request'  (duration: 130.501379ms)","trace[858595510] 'compare'  (duration: 11.643437ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:05:54.429618Z","caller":"traceutil/trace.go:171","msg":"trace[333681218] transaction","detail":"{read_only:false; response_revision:3939; number_of_response:1; }","duration":"143.203625ms","start":"2026-09-10T02:05:54.286379Z","end":"2026-09-10T02:05:54.429583Z","steps":["trace[333681218] 'process raft request'  (duration: 142.217577ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:05:54.429619Z","caller":"traceutil/trace.go:171","msg":"trace[1793156249] transaction","detail":"{read_only:false; response_revision:3940; number_of_response:1; }","duration":"139.203887ms","start":"2026-09-10T02:05:54.290384Z","end":"2026-09-10T02:05:54.429588Z","steps":["trace[1793156249] 'process raft request'  (duration: 139.055423ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:08:00.236031Z","caller":"traceutil/trace.go:171","msg":"trace[1454672947] transaction","detail":"{read_only:false; response_revision:5289; number_of_response:1; }","duration":"112.611846ms","start":"2026-09-10T02:08:00.12339Z","end":"2026-09-10T02:08:00.236002Z","steps":["trace[1454672947] 'process raft request'  (duration: 112.283467ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:08:04.285231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.794555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-09-10T02:08:04.285097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.380458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fa121e1c-13e0-4eb5-8460-bdaa965eac07\" ","response":"range_response_count:1 size:3599"}
{"level":"warn","ts":"2026-09-10T02:08:04.285394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.970669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-mqk4m-tls\" ","response":"range_response_count:1 size:1965"}
{"level":"info","ts":"2026-09-10T02:08:04.285556Z","caller":"traceutil/trace.go:171","msg":"trace[172085847] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-mqk4m-tls; range_end:; response_count:1; response_revision:5436; }","duration":"144.219466ms","start":"2026-09-10T02:08:04.1413Z","end":"2026-09-10T02:08:04.285519Z","steps":["trace[172085847] 'range keys from in-memory index tree'  (duration: 143.686812ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:08:04.285423Z","caller":"traceutil/trace.go:171","msg":"trace[1545515345] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fa121e1c-13e0-4eb5-8460-bdaa965eac07; range_end:; response_count:1; response_revision:5436; }","duration":"121.740169ms","start":"2026-09-10T02:08:04.163648Z","end":"2026-09-10T02:08:04.285388Z","steps":["trace[1545515345] 'range keys from in-memory index tree'  (duration: 121.157052ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:08:04.285354Z","caller":"traceutil/trace.go:171","msg":"trace[1344456820] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5436; }","duration":"123.98119ms","start":"2026-09-10T02:08:04.161348Z","end":"2026-09-10T02:08:04.28533Z","steps":["trace[1344456820] 'count revisions from in-memory index tree'  (duration: 123.66545ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:08:07.826837Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2935}
{"level":"info","ts":"2026-09-10T02:08:07.896646Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2935,"took":"68.434392ms","hash":2955596147,"current-db-size-bytes":53837824,"current-db-size":"54 MB","current-db-size-in-use-bytes":30416896,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-10T02:08:07.89672Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2955596147,"revision":2935,"compact-revision":-1}
{"level":"info","ts":"2026-09-10T02:08:18.073719Z","caller":"traceutil/trace.go:171","msg":"trace[764826396] transaction","detail":"{read_only:false; response_revision:5688; number_of_response:1; }","duration":"104.606197ms","start":"2026-09-10T02:08:17.969087Z","end":"2026-09-10T02:08:18.073693Z","steps":["trace[764826396] 'process raft request'  (duration: 23.25255ms)","trace[764826396] 'compare'  (duration: 81.251044ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:08:18.139836Z","caller":"traceutil/trace.go:171","msg":"trace[1899567119] transaction","detail":"{read_only:false; response_revision:5689; number_of_response:1; }","duration":"169.87237ms","start":"2026-09-10T02:08:17.969936Z","end":"2026-09-10T02:08:18.139808Z","steps":["trace[1899567119] 'process raft request'  (duration: 169.658584ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:08:18.140378Z","caller":"traceutil/trace.go:171","msg":"trace[2113840484] transaction","detail":"{read_only:false; response_revision:5690; number_of_response:1; }","duration":"170.047766ms","start":"2026-09-10T02:08:17.970296Z","end":"2026-09-10T02:08:18.140344Z","steps":["trace[2113840484] 'process raft request'  (duration: 169.471629ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:08:18.140517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.803484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T02:08:18.140574Z","caller":"traceutil/trace.go:171","msg":"trace[684129981] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5691; }","duration":"131.913998ms","start":"2026-09-10T02:08:18.008646Z","end":"2026-09-10T02:08:18.14056Z","steps":["trace[684129981] 'agreement among raft nodes before linearized reading'  (duration: 131.792465ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:08:18.140412Z","caller":"traceutil/trace.go:171","msg":"trace[1374422907] linearizableReadLoop","detail":"{readStateIndex:5912; appliedIndex:5909; }","duration":"131.688681ms","start":"2026-09-10T02:08:18.00871Z","end":"2026-09-10T02:08:18.140398Z","steps":["trace[1374422907] 'read index received'  (duration: 130.826127ms)","trace[1374422907] 'applied index is now lower than readState.Index'  (duration: 861.484µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:08:18.14092Z","caller":"traceutil/trace.go:171","msg":"trace[1366584681] transaction","detail":"{read_only:false; response_revision:5691; number_of_response:1; }","duration":"167.233199ms","start":"2026-09-10T02:08:17.973674Z","end":"2026-09-10T02:08:18.140907Z","steps":["trace[1366584681] 'process raft request'  (duration: 166.408045ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:08:30.040267Z","caller":"traceutil/trace.go:171","msg":"trace[141980001] transaction","detail":"{read_only:false; response_revision:5911; number_of_response:1; }","duration":"143.013522ms","start":"2026-09-10T02:08:29.897201Z","end":"2026-09-10T02:08:30.040215Z","steps":["trace[141980001] 'process raft request'  (duration: 103.742882ms)","trace[141980001] 'compare'  (duration: 39.041394ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:08:30.232649Z","caller":"traceutil/trace.go:171","msg":"trace[506295784] transaction","detail":"{read_only:false; response_revision:5912; number_of_response:1; }","duration":"335.202727ms","start":"2026-09-10T02:08:29.897397Z","end":"2026-09-10T02:08:30.232599Z","steps":["trace[506295784] 'process raft request'  (duration: 309.058599ms)","trace[506295784] 'compare'  (duration: 25.82845ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:08:30.232798Z","caller":"traceutil/trace.go:171","msg":"trace[663504150] linearizableReadLoop","detail":"{readStateIndex:6140; appliedIndex:6137; }","duration":"242.011943ms","start":"2026-09-10T02:08:29.99074Z","end":"2026-09-10T02:08:30.232752Z","steps":["trace[663504150] 'read index received'  (duration: 10.197019ms)","trace[663504150] 'applied index is now lower than readState.Index'  (duration: 231.812254ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T02:08:30.232944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:08:29.897304Z","time spent":"335.492174ms","remote":"127.0.0.1:60636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:5820 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-09-10T02:08:30.232971Z","caller":"traceutil/trace.go:171","msg":"trace[154028571] transaction","detail":"{read_only:false; response_revision:5913; number_of_response:1; }","duration":"304.270175ms","start":"2026-09-10T02:08:29.92866Z","end":"2026-09-10T02:08:30.23293Z","steps":["trace[154028571] 'process raft request'  (duration: 303.858494ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:08:30.233157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.442926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bc8f848d-1cdd-4fdd-ab1f-028ed2cd8250\" ","response":"range_response_count:1 size:3644"}
{"level":"warn","ts":"2026-09-10T02:08:30.233177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:08:29.928631Z","time spent":"304.42572ms","remote":"127.0.0.1:60636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:5843 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-09-10T02:08:30.23321Z","caller":"traceutil/trace.go:171","msg":"trace[1716847584] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-bc8f848d-1cdd-4fdd-ab1f-028ed2cd8250; range_end:; response_count:1; response_revision:5913; }","duration":"174.575709ms","start":"2026-09-10T02:08:30.058619Z","end":"2026-09-10T02:08:30.233195Z","steps":["trace[1716847584] 'agreement among raft nodes before linearized reading'  (duration: 174.334143ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:08:30.233453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.661491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bc8f848d-1cdd-4fdd-ab1f-028ed2cd8250\" ","response":"range_response_count:1 size:3644"}
{"level":"info","ts":"2026-09-10T02:08:30.233558Z","caller":"traceutil/trace.go:171","msg":"trace[748502943] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-bc8f848d-1cdd-4fdd-ab1f-028ed2cd8250; range_end:; response_count:1; response_revision:5913; }","duration":"242.855506ms","start":"2026-09-10T02:08:29.990675Z","end":"2026-09-10T02:08:30.23353Z","steps":["trace[748502943] 'agreement among raft nodes before linearized reading'  (duration: 242.24734ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:08:40.884462Z","caller":"traceutil/trace.go:171","msg":"trace[172700310] transaction","detail":"{read_only:false; response_revision:6024; number_of_response:1; }","duration":"165.48848ms","start":"2026-09-10T02:08:40.718935Z","end":"2026-09-10T02:08:40.884423Z","steps":["trace[172700310] 'process raft request'  (duration: 165.270434ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:08:40.898035Z","caller":"traceutil/trace.go:171","msg":"trace[110805009] linearizableReadLoop","detail":"{readStateIndex:6255; appliedIndex:6253; }","duration":"145.939773ms","start":"2026-09-10T02:08:40.752052Z","end":"2026-09-10T02:08:40.897992Z","steps":["trace[110805009] 'read index received'  (duration: 132.290348ms)","trace[110805009] 'applied index is now lower than readState.Index'  (duration: 13.647225ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:08:40.898081Z","caller":"traceutil/trace.go:171","msg":"trace[909847593] transaction","detail":"{read_only:false; response_revision:6025; number_of_response:1; }","duration":"178.616872ms","start":"2026-09-10T02:08:40.719435Z","end":"2026-09-10T02:08:40.898052Z","steps":["trace[909847593] 'process raft request'  (duration: 178.339104ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:08:40.898389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.309453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-09-10T02:08:40.898495Z","caller":"traceutil/trace.go:171","msg":"trace[633828847] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:6025; }","duration":"146.488268ms","start":"2026-09-10T02:08:40.751981Z","end":"2026-09-10T02:08:40.89847Z","steps":["trace[633828847] 'agreement among raft nodes before linearized reading'  (duration: 146.218561ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:13:07.835623Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5505}
{"level":"info","ts":"2026-09-10T02:13:07.923682Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5505,"took":"86.120276ms","hash":508467601,"current-db-size-bytes":53837824,"current-db-size":"54 MB","current-db-size-in-use-bytes":28884992,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-09-10T02:13:07.923765Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":508467601,"revision":5505,"compact-revision":2935}
{"level":"warn","ts":"2026-09-10T02:14:39.855667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.463754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"}
{"level":"info","ts":"2026-09-10T02:14:39.855775Z","caller":"traceutil/trace.go:171","msg":"trace[1442478723] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8721; }","duration":"343.638469ms","start":"2026-09-10T02:14:39.512112Z","end":"2026-09-10T02:14:39.855751Z","steps":["trace[1442478723] 'range keys from in-memory index tree'  (duration: 343.363342ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:14:39.855817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:14:39.512086Z","time spent":"343.721462ms","remote":"127.0.0.1:60522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1877,"request content":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-09-10T02:14:50.912148Z","caller":"traceutil/trace.go:171","msg":"trace[358780306] linearizableReadLoop","detail":"{readStateIndex:9099; appliedIndex:9098; }","duration":"132.635517ms","start":"2026-09-10T02:14:50.779476Z","end":"2026-09-10T02:14:50.912112Z","steps":["trace[358780306] 'read index received'  (duration: 132.389541ms)","trace[358780306] 'applied index is now lower than readState.Index'  (duration: 244.796µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:14:50.912205Z","caller":"traceutil/trace.go:171","msg":"trace[1414546412] transaction","detail":"{read_only:false; response_revision:8780; number_of_response:1; }","duration":"160.318078ms","start":"2026-09-10T02:14:50.751854Z","end":"2026-09-10T02:14:50.912173Z","steps":["trace[1414546412] 'process raft request'  (duration: 160.057811ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:14:50.912446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.917656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T02:14:50.912571Z","caller":"traceutil/trace.go:171","msg":"trace[191330680] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:8780; }","duration":"133.133701ms","start":"2026-09-10T02:14:50.779408Z","end":"2026-09-10T02:14:50.912541Z","steps":["trace[191330680] 'agreement among raft nodes before linearized reading'  (duration: 132.883684ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:14:50.922589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.972359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T02:14:50.922652Z","caller":"traceutil/trace.go:171","msg":"trace[1928946932] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8781; }","duration":"140.078862ms","start":"2026-09-10T02:14:50.782557Z","end":"2026-09-10T02:14:50.922635Z","steps":["trace[1928946932] 'agreement among raft nodes before linearized reading'  (duration: 139.947248ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:14:50.922883Z","caller":"traceutil/trace.go:171","msg":"trace[1750388714] transaction","detail":"{read_only:false; response_revision:8781; number_of_response:1; }","duration":"103.460594ms","start":"2026-09-10T02:14:50.819381Z","end":"2026-09-10T02:14:50.922841Z","steps":["trace[1750388714] 'process raft request'  (duration: 103.044592ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:14:51.148552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.148563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"}
{"level":"info","ts":"2026-09-10T02:14:51.148659Z","caller":"traceutil/trace.go:171","msg":"trace[1769426711] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:8781; }","duration":"200.334107ms","start":"2026-09-10T02:14:50.948303Z","end":"2026-09-10T02:14:51.148637Z","steps":["trace[1769426711] 'range keys from in-memory index tree'  (duration: 199.920377ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:14:51.148582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.954288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-09-10T02:14:51.14879Z","caller":"traceutil/trace.go:171","msg":"trace[735723864] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8781; }","duration":"196.227876ms","start":"2026-09-10T02:14:50.952542Z","end":"2026-09-10T02:14:51.14877Z","steps":["trace[735723864] 'range keys from in-memory index tree'  (duration: 195.768953ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:14:51.355715Z","caller":"traceutil/trace.go:171","msg":"trace[1761107293] transaction","detail":"{read_only:false; response_revision:8783; number_of_response:1; }","duration":"133.742118ms","start":"2026-09-10T02:14:51.221914Z","end":"2026-09-10T02:14:51.355656Z","steps":["trace[1761107293] 'process raft request'  (duration: 37.79664ms)","trace[1761107293] 'compare'  (duration: 95.706171ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:14:52.577283Z","caller":"traceutil/trace.go:171","msg":"trace[1603356107] transaction","detail":"{read_only:false; response_revision:8786; number_of_response:1; }","duration":"331.451693ms","start":"2026-09-10T02:14:52.245779Z","end":"2026-09-10T02:14:52.577231Z","steps":["trace[1603356107] 'process raft request'  (duration: 331.228907ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:14:52.57748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.784428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-09-10T02:14:52.577546Z","caller":"traceutil/trace.go:171","msg":"trace[1789361099] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8786; }","duration":"297.895761ms","start":"2026-09-10T02:14:52.279638Z","end":"2026-09-10T02:14:52.577533Z","steps":["trace[1789361099] 'agreement among raft nodes before linearized reading'  (duration: 297.686805ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:14:52.577647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:14:52.245748Z","time spent":"331.69884ms","remote":"127.0.0.1:60636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:8775 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-09-10T02:14:52.57721Z","caller":"traceutil/trace.go:171","msg":"trace[142917621] linearizableReadLoop","detail":"{readStateIndex:9106; appliedIndex:9105; }","duration":"297.51833ms","start":"2026-09-10T02:14:52.279664Z","end":"2026-09-10T02:14:52.577183Z","steps":["trace[142917621] 'read index received'  (duration: 297.341336ms)","trace[142917621] 'applied index is now lower than readState.Index'  (duration: 175.384µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T02:14:53.475073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.024346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-09-10T02:14:53.47517Z","caller":"traceutil/trace.go:171","msg":"trace[1001186713] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8793; }","duration":"114.21466ms","start":"2026-09-10T02:14:53.360936Z","end":"2026-09-10T02:14:53.475151Z","steps":["trace[1001186713] 'range keys from in-memory index tree'  (duration: 113.758368ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:15:22.894796Z","caller":"traceutil/trace.go:171","msg":"trace[252971741] transaction","detail":"{read_only:false; response_revision:9002; number_of_response:1; }","duration":"110.339583ms","start":"2026-09-10T02:15:22.784417Z","end":"2026-09-10T02:15:22.894757Z","steps":["trace[252971741] 'process raft request'  (duration: 110.138627ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:15:23.218361Z","caller":"traceutil/trace.go:171","msg":"trace[370775314] transaction","detail":"{read_only:false; response_revision:9004; number_of_response:1; }","duration":"317.694155ms","start":"2026-09-10T02:15:22.900627Z","end":"2026-09-10T02:15:23.218322Z","steps":["trace[370775314] 'process raft request'  (duration: 317.260993ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:15:23.218377Z","caller":"traceutil/trace.go:171","msg":"trace[1251625202] linearizableReadLoop","detail":"{readStateIndex:9334; appliedIndex:9331; }","duration":"210.504048ms","start":"2026-09-10T02:15:23.007833Z","end":"2026-09-10T02:15:23.218337Z","steps":["trace[1251625202] 'read index received'  (duration: 210.157868ms)","trace[1251625202] 'applied index is now lower than readState.Index'  (duration: 344.48µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:15:23.218422Z","caller":"traceutil/trace.go:171","msg":"trace[802209512] transaction","detail":"{read_only:false; response_revision:9006; number_of_response:1; }","duration":"317.495519ms","start":"2026-09-10T02:15:22.900895Z","end":"2026-09-10T02:15:23.218391Z","steps":["trace[802209512] 'process raft request'  (duration: 317.310534ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:15:23.21855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:15:22.900604Z","time spent":"317.845179ms","remote":"127.0.0.1:60636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:8994 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-09-10T02:15:23.218638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:15:22.900881Z","time spent":"317.621193ms","remote":"127.0.0.1:60636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:8995 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-09-10T02:15:23.218641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.778985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T02:15:23.218737Z","caller":"traceutil/trace.go:171","msg":"trace[605347338] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9006; }","duration":"210.9594ms","start":"2026-09-10T02:15:23.007754Z","end":"2026-09-10T02:15:23.218713Z","steps":["trace[605347338] 'agreement among raft nodes before linearized reading'  (duration: 210.797625ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:15:23.21869Z","caller":"traceutil/trace.go:171","msg":"trace[1382967954] transaction","detail":"{read_only:false; response_revision:9005; number_of_response:1; }","duration":"317.558041ms","start":"2026-09-10T02:15:22.900806Z","end":"2026-09-10T02:15:23.218365Z","steps":["trace[1382967954] 'process raft request'  (duration: 317.316245ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:15:23.218905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:15:22.900792Z","time spent":"318.013893ms","remote":"127.0.0.1:60636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:8993 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-09-10T02:15:29.566916Z","caller":"traceutil/trace.go:171","msg":"trace[1737474545] transaction","detail":"{read_only:false; response_revision:9040; number_of_response:1; }","duration":"119.282159ms","start":"2026-09-10T02:15:29.447595Z","end":"2026-09-10T02:15:29.566877Z","steps":["trace[1737474545] 'process raft request'  (duration: 31.603969ms)","trace[1737474545] 'compare'  (duration: 87.448574ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:15:36.625524Z","caller":"traceutil/trace.go:171","msg":"trace[92975353] transaction","detail":"{read_only:false; number_of_response:1; response_revision:9118; }","duration":"129.200792ms","start":"2026-09-10T02:15:36.496292Z","end":"2026-09-10T02:15:36.625492Z","steps":["trace[92975353] 'process raft request'  (duration: 98.421576ms)","trace[92975353] 'compare'  (duration: 30.647662ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:15:36.651643Z","caller":"traceutil/trace.go:171","msg":"trace[1976215114] transaction","detail":"{read_only:false; response_revision:9119; number_of_response:1; }","duration":"151.816094ms","start":"2026-09-10T02:15:36.499791Z","end":"2026-09-10T02:15:36.651608Z","steps":["trace[1976215114] 'process raft request'  (duration: 151.645779ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:15:37.139397Z","caller":"traceutil/trace.go:171","msg":"trace[1819699471] transaction","detail":"{read_only:false; response_revision:9121; number_of_response:1; }","duration":"118.9687ms","start":"2026-09-10T02:15:37.020404Z","end":"2026-09-10T02:15:37.139372Z","steps":["trace[1819699471] 'process raft request'  (duration: 118.323973ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:15:37.28011Z","caller":"traceutil/trace.go:171","msg":"trace[1233109513] transaction","detail":"{read_only:false; response_revision:9122; number_of_response:1; }","duration":"116.165985ms","start":"2026-09-10T02:15:37.163917Z","end":"2026-09-10T02:15:37.280083Z","steps":["trace[1233109513] 'process raft request'  (duration: 115.67073ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:15:50.983969Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000256d.wal"}
{"level":"info","ts":"2026-09-10T02:16:33.466496Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b512f7d8ac93be25","local-member-applied-index":10002,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-10T02:16:33.476456Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10002}
{"level":"info","ts":"2026-09-10T02:16:33.476575Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5002}
{"level":"info","ts":"2026-09-10T02:18:07.843107Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7960}
{"level":"info","ts":"2026-09-10T02:18:07.932789Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7960,"took":"86.632303ms","hash":1181673902,"current-db-size-bytes":53837824,"current-db-size":"54 MB","current-db-size-in-use-bytes":25546752,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-09-10T02:18:07.932867Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1181673902,"revision":7960,"compact-revision":5505}
{"level":"info","ts":"2026-09-10T02:23:07.851415Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10373}
{"level":"info","ts":"2026-09-10T02:23:07.940523Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10373,"took":"86.248078ms","hash":1745774760,"current-db-size-bytes":53837824,"current-db-size":"54 MB","current-db-size-in-use-bytes":28536832,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-09-10T02:23:07.940602Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1745774760,"revision":10373,"compact-revision":7960}
{"level":"info","ts":"2026-09-10T02:26:37.560133Z","caller":"traceutil/trace.go:171","msg":"trace[1797622766] transaction","detail":"{read_only:false; response_revision:14151; number_of_response:1; }","duration":"154.680048ms","start":"2026-09-10T02:26:37.405428Z","end":"2026-09-10T02:26:37.560109Z","steps":["trace[1797622766] 'process raft request'  (duration: 154.259136ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:27:19.859179Z","caller":"traceutil/trace.go:171","msg":"trace[88621407] transaction","detail":"{read_only:false; response_revision:14392; number_of_response:1; }","duration":"159.027646ms","start":"2026-09-10T02:27:19.700109Z","end":"2026-09-10T02:27:19.859137Z","steps":["trace[88621407] 'process raft request'  (duration: 158.711928ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:27:20.153052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.887516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T02:27:20.15313Z","caller":"traceutil/trace.go:171","msg":"trace[802400766] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14396; }","duration":"145.039501ms","start":"2026-09-10T02:27:20.008072Z","end":"2026-09-10T02:27:20.153111Z","steps":["trace[802400766] 'range keys from in-memory index tree'  (duration: 144.746013ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:27:20.46416Z","caller":"traceutil/trace.go:171","msg":"trace[1405067254] transaction","detail":"{read_only:false; response_revision:14397; number_of_response:1; }","duration":"304.82835ms","start":"2026-09-10T02:27:20.159299Z","end":"2026-09-10T02:27:20.464127Z","steps":["trace[1405067254] 'process raft request'  (duration: 304.638815ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:27:20.464409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:27:20.159273Z","time spent":"304.987633ms","remote":"127.0.0.1:60636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/cert-manager/cert-manager-controller\" mod_revision:14299 > success:<request_put:<key:\"/registry/leases/cert-manager/cert-manager-controller\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/cert-manager/cert-manager-controller\" > >"}
{"level":"info","ts":"2026-09-10T02:27:20.917566Z","caller":"traceutil/trace.go:171","msg":"trace[1411548278] transaction","detail":"{read_only:false; response_revision:14398; number_of_response:1; }","duration":"756.431299ms","start":"2026-09-10T02:27:20.161102Z","end":"2026-09-10T02:27:20.917533Z","steps":["trace[1411548278] 'process raft request'  (duration: 756.133281ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:27:20.917779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:27:20.161083Z","time spent":"756.576894ms","remote":"127.0.0.1:60636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:14383 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-09-10T02:27:20.917753Z","caller":"traceutil/trace.go:171","msg":"trace[1740752479] transaction","detail":"{read_only:false; response_revision:14399; number_of_response:1; }","duration":"628.663034ms","start":"2026-09-10T02:27:20.289055Z","end":"2026-09-10T02:27:20.917718Z","steps":["trace[1740752479] 'process raft request'  (duration: 628.427688ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:27:20.918053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:27:20.289021Z","time spent":"628.88813ms","remote":"127.0.0.1:60636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:14384 > 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-09-10T02:27:20.920092Z","caller":"traceutil/trace.go:171","msg":"trace[1647242179] linearizableReadLoop","detail":"{readStateIndex:14903; appliedIndex:14900; }","duration":"404.183641ms","start":"2026-09-10T02:27:20.515892Z","end":"2026-09-10T02:27:20.920075Z","steps":["trace[1647242179] 'read index received'  (duration: 401.476777ms)","trace[1647242179] 'applied index is now lower than readState.Index'  (duration: 2.705694ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T02:27:20.920393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.486929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12210"}
{"level":"info","ts":"2026-09-10T02:27:20.920476Z","caller":"traceutil/trace.go:171","msg":"trace[1680616331] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14400; }","duration":"404.632023ms","start":"2026-09-10T02:27:20.515823Z","end":"2026-09-10T02:27:20.920455Z","steps":["trace[1680616331] 'agreement among raft nodes before linearized reading'  (duration: 404.324674ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:27:20.920513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:27:20.515795Z","time spent":"404.710325ms","remote":"127.0.0.1:60548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12234,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"info","ts":"2026-09-10T02:27:20.920756Z","caller":"traceutil/trace.go:171","msg":"trace[293288617] transaction","detail":"{read_only:false; response_revision:14400; number_of_response:1; }","duration":"426.655821ms","start":"2026-09-10T02:27:20.49406Z","end":"2026-09-10T02:27:20.920716Z","steps":["trace[293288617] 'process raft request'  (duration: 425.215332ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:27:20.920947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:27:20.494021Z","time spent":"426.829746ms","remote":"127.0.0.1:60636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:14386 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-09-10T02:27:20.920993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.785395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T02:27:20.921065Z","caller":"traceutil/trace.go:171","msg":"trace[1607703507] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:14400; }","duration":"289.929619ms","start":"2026-09-10T02:27:20.631114Z","end":"2026-09-10T02:27:20.921043Z","steps":["trace[1607703507] 'agreement among raft nodes before linearized reading'  (duration: 289.785825ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:28:07.860637Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12745}
{"level":"info","ts":"2026-09-10T02:28:07.956467Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12745,"took":"92.329157ms","hash":2367455681,"current-db-size-bytes":53837824,"current-db-size":"54 MB","current-db-size-in-use-bytes":28987392,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-09-10T02:28:07.956566Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2367455681,"revision":12745,"compact-revision":10373}
{"level":"info","ts":"2026-09-10T02:28:34.504132Z","caller":"traceutil/trace.go:171","msg":"trace[938651204] transaction","detail":"{read_only:false; response_revision:15326; number_of_response:1; }","duration":"163.934903ms","start":"2026-09-10T02:28:34.340169Z","end":"2026-09-10T02:28:34.504104Z","steps":["trace[938651204] 'process raft request'  (duration: 163.765779ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:28:34.504582Z","caller":"traceutil/trace.go:171","msg":"trace[682201208] linearizableReadLoop","detail":"{readStateIndex:15859; appliedIndex:15859; }","duration":"164.036887ms","start":"2026-09-10T02:28:34.340525Z","end":"2026-09-10T02:28:34.504562Z","steps":["trace[682201208] 'read index received'  (duration: 164.031076ms)","trace[682201208] 'applied index is now lower than readState.Index'  (duration: 4.031µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T02:28:34.504872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.303694ms","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-09-10T02:28:34.504966Z","caller":"traceutil/trace.go:171","msg":"trace[1446234002] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15326; }","duration":"164.430567ms","start":"2026-09-10T02:28:34.340514Z","end":"2026-09-10T02:28:34.504945Z","steps":["trace[1446234002] 'agreement among raft nodes before linearized reading'  (duration: 164.194061ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:28:34.505266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.50128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-2hd22\" ","response":"range_response_count:1 size:9794"}
{"level":"info","ts":"2026-09-10T02:28:34.505383Z","caller":"traceutil/trace.go:171","msg":"trace[1107520698] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-2hd22; range_end:; response_count:1; response_revision:15326; }","duration":"131.618063ms","start":"2026-09-10T02:28:34.373753Z","end":"2026-09-10T02:28:34.505371Z","steps":["trace[1107520698] 'agreement among raft nodes before linearized reading'  (duration: 131.422836ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:28:34.505279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.720615ms","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-09-10T02:28:34.505672Z","caller":"traceutil/trace.go:171","msg":"trace[430925535] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15326; }","duration":"165.139148ms","start":"2026-09-10T02:28:34.340517Z","end":"2026-09-10T02:28:34.505656Z","steps":["trace[430925535] 'agreement among raft nodes before linearized reading'  (duration: 164.633763ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:28:34.50562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.166067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-09-10T02:28:34.505936Z","caller":"traceutil/trace.go:171","msg":"trace[2035014465] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:15326; }","duration":"153.507116ms","start":"2026-09-10T02:28:34.352393Z","end":"2026-09-10T02:28:34.5059Z","steps":["trace[2035014465] 'agreement among raft nodes before linearized reading'  (duration: 153.151676ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:29:08.854943Z","caller":"traceutil/trace.go:171","msg":"trace[1764097671] transaction","detail":"{read_only:false; response_revision:15510; number_of_response:1; }","duration":"119.800746ms","start":"2026-09-10T02:29:08.735079Z","end":"2026-09-10T02:29:08.85488Z","steps":["trace[1764097671] 'process raft request'  (duration: 119.549339ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:29:09.47991Z","caller":"traceutil/trace.go:171","msg":"trace[1625010237] transaction","detail":"{read_only:false; response_revision:15511; number_of_response:1; }","duration":"107.473525ms","start":"2026-09-10T02:29:09.372402Z","end":"2026-09-10T02:29:09.479875Z","steps":["trace[1625010237] 'process raft request'  (duration: 107.29151ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:29:09.622374Z","caller":"traceutil/trace.go:171","msg":"trace[1888903699] linearizableReadLoop","detail":"{readStateIndex:16052; appliedIndex:16051; }","duration":"110.557161ms","start":"2026-09-10T02:29:09.511779Z","end":"2026-09-10T02:29:09.622336Z","steps":["trace[1888903699] 'read index received'  (duration: 109.028579ms)","trace[1888903699] 'applied index is now lower than readState.Index'  (duration: 1.526971ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:29:09.62248Z","caller":"traceutil/trace.go:171","msg":"trace[188713189] transaction","detail":"{read_only:false; response_revision:15512; number_of_response:1; }","duration":"211.311751ms","start":"2026-09-10T02:29:09.411118Z","end":"2026-09-10T02:29:09.62243Z","steps":["trace[188713189] 'process raft request'  (duration: 209.760899ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:29:09.622634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.842159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-8jpvc\" ","response":"range_response_count:1 size:22123"}
{"level":"info","ts":"2026-09-10T02:29:09.622734Z","caller":"traceutil/trace.go:171","msg":"trace[1813798956] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-8jpvc; range_end:; response_count:1; response_revision:15512; }","duration":"111.000463ms","start":"2026-09-10T02:29:09.511713Z","end":"2026-09-10T02:29:09.622713Z","steps":["trace[1813798956] 'agreement among raft nodes before linearized reading'  (duration: 110.759986ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:29:09.622755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.869799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-09-10T02:29:09.622806Z","caller":"traceutil/trace.go:171","msg":"trace[1168978978] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15512; }","duration":"106.967752ms","start":"2026-09-10T02:29:09.515826Z","end":"2026-09-10T02:29:09.622794Z","steps":["trace[1168978978] 'agreement among raft nodes before linearized reading'  (duration: 106.725945ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:29:09.624216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.430061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-10T02:29:09.624282Z","caller":"traceutil/trace.go:171","msg":"trace[1829670223] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15512; }","duration":"100.555615ms","start":"2026-09-10T02:29:09.52371Z","end":"2026-09-10T02:29:09.624266Z","steps":["trace[1829670223] 'agreement among raft nodes before linearized reading'  (duration: 100.448652ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:33:07.872319Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14879}
{"level":"info","ts":"2026-09-10T02:33:07.99123Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14879,"took":"114.731606ms","hash":2389145746,"current-db-size-bytes":53837824,"current-db-size":"54 MB","current-db-size-in-use-bytes":30855168,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-09-10T02:33:07.99138Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2389145746,"revision":14879,"compact-revision":12745}
{"level":"info","ts":"2026-09-10T02:34:58.100323Z","caller":"traceutil/trace.go:171","msg":"trace[483864406] linearizableReadLoop","detail":"{readStateIndex:18703; appliedIndex:18702; }","duration":"183.237255ms","start":"2026-09-10T02:34:57.917051Z","end":"2026-09-10T02:34:58.100289Z","steps":["trace[483864406] 'read index received'  (duration: 182.802393ms)","trace[483864406] 'applied index is now lower than readState.Index'  (duration: 433.532µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:34:58.100445Z","caller":"traceutil/trace.go:171","msg":"trace[1048542741] transaction","detail":"{read_only:false; response_revision:18078; number_of_response:1; }","duration":"214.041445ms","start":"2026-09-10T02:34:57.886355Z","end":"2026-09-10T02:34:58.100396Z","steps":["trace[1048542741] 'process raft request'  (duration: 213.545392ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:34:58.100967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.880754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19375"}
{"level":"info","ts":"2026-09-10T02:34:58.101076Z","caller":"traceutil/trace.go:171","msg":"trace[922197927] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:18078; }","duration":"184.062879ms","start":"2026-09-10T02:34:57.916987Z","end":"2026-09-10T02:34:58.10105Z","steps":["trace[922197927] 'agreement among raft nodes before linearized reading'  (duration: 183.688669ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:35:04.442419Z","caller":"traceutil/trace.go:171","msg":"trace[1583915718] transaction","detail":"{read_only:false; response_revision:18121; number_of_response:1; }","duration":"550.910132ms","start":"2026-09-10T02:35:03.891476Z","end":"2026-09-10T02:35:04.442386Z","steps":["trace[1583915718] 'process raft request'  (duration: 550.646565ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:35:04.442627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:35:03.891438Z","time spent":"551.083096ms","remote":"127.0.0.1:60548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20870,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/libvirt-libvirt-default-lvnpp\" mod_revision:18056 > success:<request_put:<key:\"/registry/pods/openstack/libvirt-libvirt-default-lvnpp\" value_size:20806 >> failure:<request_range:<key:\"/registry/pods/openstack/libvirt-libvirt-default-lvnpp\" > >"}
{"level":"info","ts":"2026-09-10T02:35:04.691831Z","caller":"traceutil/trace.go:171","msg":"trace[914190593] transaction","detail":"{read_only:false; response_revision:18122; number_of_response:1; }","duration":"724.715527ms","start":"2026-09-10T02:35:03.967063Z","end":"2026-09-10T02:35:04.691779Z","steps":["trace[914190593] 'process raft request'  (duration: 712.262473ms)","trace[914190593] 'compare'  (duration: 12.208767ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T02:35:04.692081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:35:03.967032Z","time spent":"724.894102ms","remote":"127.0.0.1:60636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:18046 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:416 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"warn","ts":"2026-09-10T02:35:04.692186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.337111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-10T02:35:04.69231Z","caller":"traceutil/trace.go:171","msg":"trace[1671719426] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18122; }","duration":"685.539656ms","start":"2026-09-10T02:35:04.006747Z","end":"2026-09-10T02:35:04.692287Z","steps":["trace[1671719426] 'agreement among raft nodes before linearized reading'  (duration: 685.352321ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:35:04.692358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:35:04.006714Z","time spent":"685.635979ms","remote":"127.0.0.1:60350","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-09-10T02:35:04.692339Z","caller":"traceutil/trace.go:171","msg":"trace[531502053] linearizableReadLoop","detail":"{readStateIndex:18748; appliedIndex:18746; }","duration":"684.846287ms","start":"2026-09-10T02:35:04.00683Z","end":"2026-09-10T02:35:04.691676Z","steps":["trace[531502053] 'read index received'  (duration: 435.25303ms)","trace[531502053] 'applied index is now lower than readState.Index'  (duration: 249.591737ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T02:35:04.692652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.08969ms","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-09-10T02:35:04.6927Z","caller":"traceutil/trace.go:171","msg":"trace[1937010535] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18122; }","duration":"566.192913ms","start":"2026-09-10T02:35:04.126489Z","end":"2026-09-10T02:35:04.692682Z","steps":["trace[1937010535] 'agreement among raft nodes before linearized reading'  (duration: 566.002007ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:35:04.692784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.274973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-2hd22\" ","response":"range_response_count:1 size:9795"}
{"level":"info","ts":"2026-09-10T02:35:04.692837Z","caller":"traceutil/trace.go:171","msg":"trace[362426436] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-2hd22; range_end:; response_count:1; response_revision:18122; }","duration":"492.376357ms","start":"2026-09-10T02:35:04.200449Z","end":"2026-09-10T02:35:04.692825Z","steps":["trace[362426436] 'agreement among raft nodes before linearized reading'  (duration: 492.176231ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:35:04.692743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:35:04.126471Z","time spent":"566.262805ms","remote":"127.0.0.1:60636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-09-10T02:35:04.692873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:35:04.200412Z","time spent":"492.453149ms","remote":"127.0.0.1:60548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9819,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-2hd22\" "}
{"level":"warn","ts":"2026-09-10T02:35:04.692808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-09-10T02:35:04.692991Z","caller":"traceutil/trace.go:171","msg":"trace[854323618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18122; }","duration":"134.574654ms","start":"2026-09-10T02:35:04.558334Z","end":"2026-09-10T02:35:04.692909Z","steps":["trace[854323618] 'agreement among raft nodes before linearized reading'  (duration: 134.207464ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:37:17.720327Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b512f7d8ac93be25","local-member-applied-index":20003,"local-member-snapshot-index":10002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-09-10T02:37:17.738341Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20003}
{"level":"info","ts":"2026-09-10T02:37:17.738515Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15003}
{"level":"info","ts":"2026-09-10T02:38:07.879491Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17329}
{"level":"info","ts":"2026-09-10T02:38:07.991382Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17329,"took":"107.496927ms","hash":1263987196,"current-db-size-bytes":53837824,"current-db-size":"54 MB","current-db-size-in-use-bytes":34476032,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-09-10T02:38:07.991458Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1263987196,"revision":17329,"compact-revision":14879}
{"level":"info","ts":"2026-09-10T02:40:53.536023Z","caller":"traceutil/trace.go:171","msg":"trace[1065952019] linearizableReadLoop","detail":"{readStateIndex:21535; appliedIndex:21534; }","duration":"114.307654ms","start":"2026-09-10T02:40:53.421675Z","end":"2026-09-10T02:40:53.535983Z","steps":["trace[1065952019] 'read index received'  (duration: 114.069767ms)","trace[1065952019] 'applied index is now lower than readState.Index'  (duration: 236.867µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T02:40:53.536256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.54171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-10T02:40:53.5363Z","caller":"traceutil/trace.go:171","msg":"trace[1532879628] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:20822; }","duration":"114.653574ms","start":"2026-09-10T02:40:53.421631Z","end":"2026-09-10T02:40:53.536285Z","steps":["trace[1532879628] 'agreement among raft nodes before linearized reading'  (duration: 114.517119ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:40:53.536101Z","caller":"traceutil/trace.go:171","msg":"trace[80383161] transaction","detail":"{read_only:false; response_revision:20822; number_of_response:1; }","duration":"124.908786ms","start":"2026-09-10T02:40:53.411114Z","end":"2026-09-10T02:40:53.536023Z","steps":["trace[80383161] 'process raft request'  (duration: 124.667599ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:40:54.954001Z","caller":"traceutil/trace.go:171","msg":"trace[1223298918] linearizableReadLoop","detail":"{readStateIndex:21536; appliedIndex:21535; }","duration":"154.170984ms","start":"2026-09-10T02:40:54.799796Z","end":"2026-09-10T02:40:54.953967Z","steps":["trace[1223298918] 'read index received'  (duration: 154.060831ms)","trace[1223298918] 'applied index is now lower than readState.Index'  (duration: 109.083µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:40:54.954328Z","caller":"traceutil/trace.go:171","msg":"trace[1553042068] transaction","detail":"{read_only:false; response_revision:20823; number_of_response:1; }","duration":"281.068997ms","start":"2026-09-10T02:40:54.673227Z","end":"2026-09-10T02:40:54.954296Z","steps":["trace[1553042068] 'process raft request'  (duration: 280.47546ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:40:54.95458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.728959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-10T02:40:54.954667Z","caller":"traceutil/trace.go:171","msg":"trace[1620592679] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:20823; }","duration":"154.917534ms","start":"2026-09-10T02:40:54.799728Z","end":"2026-09-10T02:40:54.954646Z","steps":["trace[1620592679] 'agreement among raft nodes before linearized reading'  (duration: 154.688778ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:40:55.139641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.691461ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13701533951772661737 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:20815 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-10T02:40:55.13995Z","caller":"traceutil/trace.go:171","msg":"trace[1515064413] transaction","detail":"{read_only:false; response_revision:20825; number_of_response:1; }","duration":"127.074466ms","start":"2026-09-10T02:40:55.012849Z","end":"2026-09-10T02:40:55.139924Z","steps":["trace[1515064413] 'process raft request'  (duration: 126.988184ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:40:55.140099Z","caller":"traceutil/trace.go:171","msg":"trace[1227842687] transaction","detail":"{read_only:false; response_revision:20824; number_of_response:1; }","duration":"208.591146ms","start":"2026-09-10T02:40:54.931449Z","end":"2026-09-10T02:40:55.14004Z","steps":["trace[1227842687] 'process raft request'  (duration: 79.219326ms)","trace[1227842687] 'compare'  (duration: 128.414474ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:40:55.140308Z","caller":"traceutil/trace.go:171","msg":"trace[380722928] linearizableReadLoop","detail":"{readStateIndex:21537; appliedIndex:21536; }","duration":"186.197098ms","start":"2026-09-10T02:40:54.954098Z","end":"2026-09-10T02:40:55.140295Z","steps":["trace[380722928] 'read index received'  (duration: 56.491929ms)","trace[380722928] 'applied index is now lower than readState.Index'  (duration: 129.703659ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T02:40:55.140495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.325491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-09-10T02:40:55.140545Z","caller":"traceutil/trace.go:171","msg":"trace[1193092440] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:20825; }","duration":"323.429644ms","start":"2026-09-10T02:40:54.817101Z","end":"2026-09-10T02:40:55.140531Z","steps":["trace[1193092440] 'agreement among raft nodes before linearized reading'  (duration: 323.239119ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:40:55.140598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:40:54.817078Z","time spent":"323.500436ms","remote":"127.0.0.1:38980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":32,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "}
{"level":"warn","ts":"2026-09-10T02:40:55.500101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.240635ms","expected-duration":"100ms","prefix":"","request":"header:<ID:13701533951772661742 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:20817 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-09-10T02:40:55.500243Z","caller":"traceutil/trace.go:171","msg":"trace[2111886228] linearizableReadLoop","detail":"{readStateIndex:21539; appliedIndex:21538; }","duration":"246.839313ms","start":"2026-09-10T02:40:55.253384Z","end":"2026-09-10T02:40:55.500224Z","steps":["trace[2111886228] 'read index received'  (duration: 50.33545ms)","trace[2111886228] 'applied index is now lower than readState.Index'  (duration: 196.502553ms)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:40:55.500647Z","caller":"traceutil/trace.go:171","msg":"trace[10091896] transaction","detail":"{read_only:false; response_revision:20826; number_of_response:1; }","duration":"336.347191ms","start":"2026-09-10T02:40:55.16428Z","end":"2026-09-10T02:40:55.500627Z","steps":["trace[10091896] 'process raft request'  (duration: 139.475017ms)","trace[10091896] 'compare'  (duration: 195.930147ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T02:40:55.500729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-10T02:40:55.164261Z","time spent":"336.428953ms","remote":"127.0.0.1:60636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:20817 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:409 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-09-10T02:40:55.5013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.883571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"warn","ts":"2026-09-10T02:40:55.501391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.41767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"}
{"level":"info","ts":"2026-09-10T02:40:55.501405Z","caller":"traceutil/trace.go:171","msg":"trace[1392841983] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20826; }","duration":"248.058135ms","start":"2026-09-10T02:40:55.253325Z","end":"2026-09-10T02:40:55.501383Z","steps":["trace[1392841983] 'agreement among raft nodes before linearized reading'  (duration: 247.700595ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:40:55.501429Z","caller":"traceutil/trace.go:171","msg":"trace[1084741842] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20826; }","duration":"246.517602ms","start":"2026-09-10T02:40:55.2549Z","end":"2026-09-10T02:40:55.501418Z","steps":["trace[1084741842] 'agreement among raft nodes before linearized reading'  (duration: 246.367878ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:40:55.501727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.466189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-09-10T02:40:55.501764Z","caller":"traceutil/trace.go:171","msg":"trace[1132702375] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20826; }","duration":"226.599172ms","start":"2026-09-10T02:40:55.275156Z","end":"2026-09-10T02:40:55.501755Z","steps":["trace[1132702375] 'agreement among raft nodes before linearized reading'  (duration: 226.491309ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:40:55.50174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.33516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-09-10T02:40:55.501832Z","caller":"traceutil/trace.go:171","msg":"trace[1715381888] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20826; }","duration":"224.478884ms","start":"2026-09-10T02:40:55.277332Z","end":"2026-09-10T02:40:55.501811Z","steps":["trace[1715381888] 'agreement among raft nodes before linearized reading'  (duration: 224.275708ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:40:55.76201Z","caller":"traceutil/trace.go:171","msg":"trace[229172329] transaction","detail":"{read_only:false; response_revision:20830; number_of_response:1; }","duration":"250.10663ms","start":"2026-09-10T02:40:55.511868Z","end":"2026-09-10T02:40:55.761975Z","steps":["trace[229172329] 'process raft request'  (duration: 250.051629ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:40:55.762676Z","caller":"traceutil/trace.go:171","msg":"trace[1665256004] transaction","detail":"{read_only:false; response_revision:20828; number_of_response:1; }","duration":"253.34538ms","start":"2026-09-10T02:40:55.509314Z","end":"2026-09-10T02:40:55.762659Z","steps":["trace[1665256004] 'process raft request'  (duration: 252.315992ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:40:55.762866Z","caller":"traceutil/trace.go:171","msg":"trace[2117078349] transaction","detail":"{read_only:false; response_revision:20829; number_of_response:1; }","duration":"253.420432ms","start":"2026-09-10T02:40:55.509433Z","end":"2026-09-10T02:40:55.762853Z","steps":["trace[2117078349] 'process raft request'  (duration: 252.434586ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:40:55.763647Z","caller":"traceutil/trace.go:171","msg":"trace[1810561401] linearizableReadLoop","detail":"{readStateIndex:21543; appliedIndex:21543; }","duration":"222.365386ms","start":"2026-09-10T02:40:55.541257Z","end":"2026-09-10T02:40:55.763622Z","steps":["trace[1810561401] 'read index received'  (duration: 222.355616ms)","trace[1810561401] 'applied index is now lower than readState.Index'  (duration: 7.56µs)"],"step_count":2}
{"level":"warn","ts":"2026-09-10T02:40:55.763892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.617183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-09-10T02:40:55.76396Z","caller":"traceutil/trace.go:171","msg":"trace[415269765] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20830; }","duration":"222.763077ms","start":"2026-09-10T02:40:55.54116Z","end":"2026-09-10T02:40:55.763923Z","steps":["trace[415269765] 'agreement among raft nodes before linearized reading'  (duration: 222.558502ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:43:07.891484Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19656}
{"level":"info","ts":"2026-09-10T02:43:08.03247Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19656,"took":"135.844228ms","hash":1200425221,"current-db-size-bytes":53837824,"current-db-size":"54 MB","current-db-size-in-use-bytes":29958144,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-10T02:43:08.032557Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1200425221,"revision":19656,"compact-revision":17329}
{"level":"info","ts":"2026-09-10T02:44:53.114198Z","caller":"traceutil/trace.go:171","msg":"trace[1466049280] linearizableReadLoop","detail":"{readStateIndex:23997; appliedIndex:23996; }","duration":"116.761207ms","start":"2026-09-10T02:44:52.997406Z","end":"2026-09-10T02:44:53.114168Z","steps":["trace[1466049280] 'read index received'  (duration: 116.404717ms)","trace[1466049280] 'applied index is now lower than readState.Index'  (duration: 355.64µs)"],"step_count":2}
{"level":"info","ts":"2026-09-10T02:44:53.114321Z","caller":"traceutil/trace.go:171","msg":"trace[271337538] transaction","detail":"{read_only:false; response_revision:23205; number_of_response:1; }","duration":"119.838542ms","start":"2026-09-10T02:44:52.994424Z","end":"2026-09-10T02:44:53.114263Z","steps":["trace[271337538] 'process raft request'  (duration: 119.508883ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:44:53.114467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.986968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-10T02:44:53.114526Z","caller":"traceutil/trace.go:171","msg":"trace[656251793] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23205; }","duration":"110.096611ms","start":"2026-09-10T02:44:53.004415Z","end":"2026-09-10T02:44:53.114511Z","steps":["trace[656251793] 'agreement among raft nodes before linearized reading'  (duration: 109.960628ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:44:53.114567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.130437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/cert-manager-test\" ","response":"range_response_count:1 size:1799"}
{"level":"info","ts":"2026-09-10T02:44:53.114665Z","caller":"traceutil/trace.go:171","msg":"trace[405232994] range","detail":"{range_begin:/registry/namespaces/cert-manager-test; range_end:; response_count:1; response_revision:23205; }","duration":"117.283681ms","start":"2026-09-10T02:44:52.99736Z","end":"2026-09-10T02:44:53.114644Z","steps":["trace[405232994] 'agreement among raft nodes before linearized reading'  (duration: 117.005793ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-10T02:45:02.244867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.777566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-09-10T02:45:02.244971Z","caller":"traceutil/trace.go:171","msg":"trace[16791406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23343; }","duration":"239.92362ms","start":"2026-09-10T02:45:02.005024Z","end":"2026-09-10T02:45:02.244948Z","steps":["trace[16791406] 'range keys from in-memory index tree'  (duration: 239.649682ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:45:02.245515Z","caller":"traceutil/trace.go:171","msg":"trace[2131995963] transaction","detail":"{read_only:false; response_revision:23345; number_of_response:1; }","duration":"172.792428ms","start":"2026-09-10T02:45:02.072706Z","end":"2026-09-10T02:45:02.245498Z","steps":["trace[2131995963] 'process raft request'  (duration: 172.716166ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:45:02.245733Z","caller":"traceutil/trace.go:171","msg":"trace[551653577] transaction","detail":"{read_only:false; response_revision:23344; number_of_response:1; }","duration":"222.801684ms","start":"2026-09-10T02:45:02.022917Z","end":"2026-09-10T02:45:02.245718Z","steps":["trace[551653577] 'process raft request'  (duration: 220.615685ms)"],"step_count":1}
{"level":"info","ts":"2026-09-10T02:48:07.89992Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21885}
{"level":"info","ts":"2026-09-10T02:48:08.034766Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21885,"took":"130.253471ms","hash":3852720823,"current-db-size-bytes":54681600,"current-db-size":"55 MB","current-db-size-in-use-bytes":43286528,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-09-10T02:48:08.034854Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3852720823,"revision":21885,"compact-revision":19656}
{"level":"info","ts":"2026-09-10T02:53:07.909681Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25023}
{"level":"info","ts":"2026-09-10T02:53:08.086333Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25023,"took":"166.468277ms","hash":2787455506,"current-db-size-bytes":54681600,"current-db-size":"55 MB","current-db-size-in-use-bytes":29908992,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-09-10T02:53:08.086425Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2787455506,"revision":25023,"compact-revision":21885}