{"level":"warn","ts":"2026-09-18T15:16:20.494349Z","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-18T15:16:20.494503Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.54: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.54:2380","--initial-cluster=instance=https://162.253.55.54:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.54:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.54: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-18T15:16:20.494604Z","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-18T15:16:20.494621Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.54:2380"]} {"level":"info","ts":"2026-09-18T15:16:20.494643Z","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-18T15:16:20.495586Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.54:2379"]} {"level":"info","ts":"2026-09-18T15:16:20.495692Z","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":8,"max-cpu-available":8,"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.54:2380"],"listen-peer-urls":["https://162.253.55.54:2380"],"advertise-client-urls":["https://162.253.55.54:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.54:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.54: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-18T15:16:20.503139Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.133978ms"} {"level":"info","ts":"2026-09-18T15:16:20.513583Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"353030364a385dbf","cluster-id":"1e619908a4cffd8f"} {"level":"info","ts":"2026-09-18T15:16:20.513703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T15:16:20.513731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf became follower at term 0"} {"level":"info","ts":"2026-09-18T15:16:20.513741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 353030364a385dbf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T15:16:20.513748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf became follower at term 1"} {"level":"info","ts":"2026-09-18T15:16:20.513811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf switched to configuration voters=(3832616292623867327)"} {"level":"warn","ts":"2026-09-18T15:16:20.52262Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T15:16:20.527775Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T15:16:20.52931Z","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-18T15:16:20.53137Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"353030364a385dbf","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T15:16:20.531549Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"353030364a385dbf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T15:16:20.531682Z","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-18T15:16:20.531754Z","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-18T15:16:20.531761Z","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-18T15:16:20.534473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf switched to configuration voters=(3832616292623867327)"} {"level":"info","ts":"2026-09-18T15:16:20.534619Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1e619908a4cffd8f","local-member-id":"353030364a385dbf","added-peer-id":"353030364a385dbf","added-peer-peer-urls":["https://162.253.55.54:2380"]} {"level":"info","ts":"2026-09-18T15:16:20.535124Z","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-18T15:16:20.535283Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.54:2380"} {"level":"info","ts":"2026-09-18T15:16:20.535376Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.54:2380"} {"level":"info","ts":"2026-09-18T15:16:20.535506Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"353030364a385dbf","initial-advertise-peer-urls":["https://162.253.55.54:2380"],"listen-peer-urls":["https://162.253.55.54:2380"],"advertise-client-urls":["https://162.253.55.54:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.54:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T15:16:20.535549Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T15:16:20.814962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T15:16:20.815014Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T15:16:20.815043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf received MsgPreVoteResp from 353030364a385dbf at term 1"} {"level":"info","ts":"2026-09-18T15:16:20.815054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf became candidate at term 2"} {"level":"info","ts":"2026-09-18T15:16:20.815059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf received MsgVoteResp from 353030364a385dbf at term 2"} {"level":"info","ts":"2026-09-18T15:16:20.815068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf became leader at term 2"} {"level":"info","ts":"2026-09-18T15:16:20.815075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 353030364a385dbf elected leader 353030364a385dbf at term 2"} {"level":"info","ts":"2026-09-18T15:16:20.823232Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"353030364a385dbf","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.54:2379]}","request-path":"/0/members/353030364a385dbf/attributes","cluster-id":"1e619908a4cffd8f","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T15:16:20.823124Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:16:20.823491Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T15:16:20.823654Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T15:16:20.826507Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.54:2379"} {"level":"info","ts":"2026-09-18T15:16:20.827418Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T15:16:20.827539Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T15:16:20.829144Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"1e619908a4cffd8f","local-member-id":"353030364a385dbf","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:16:20.829249Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:16:20.8293Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:16:20.836421Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-18T15:16:23.888078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.26184ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-09-18T15:16:23.888342Z","caller":"traceutil/trace.go:171","msg":"trace[1448168029] linearizableReadLoop","detail":"{readStateIndex:79; appliedIndex:78; }","duration":"337.252195ms","start":"2026-09-18T15:16:23.551068Z","end":"2026-09-18T15:16:23.888321Z","steps":["trace[1448168029] 'read index received' (duration: 199.080689ms)","trace[1448168029] 'applied index is now lower than readState.Index' (duration: 138.169896ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:16:23.888545Z","caller":"traceutil/trace.go:171","msg":"trace[1885999202] transaction","detail":"{read_only:false; response_revision:76; number_of_response:1; }","duration":"338.267101ms","start":"2026-09-18T15:16:23.550132Z","end":"2026-09-18T15:16:23.888399Z","steps":["trace[1885999202] 'process raft request' (duration: 199.998134ms)","trace[1885999202] 'compare' (duration: 137.034407ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:16:23.88877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.59741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T15:16:23.888971Z","caller":"traceutil/trace.go:171","msg":"trace[84931420] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:0; response_revision:76; }","duration":"337.876036ms","start":"2026-09-18T15:16:23.551057Z","end":"2026-09-18T15:16:23.888933Z","steps":["trace[84931420] 'agreement among raft nodes before linearized reading' (duration: 337.341056ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:23.888943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:23.55012Z","time spent":"338.626927ms","remote":"127.0.0.1:56752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T15:16:23.889038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:23.551049Z","time spent":"337.972917ms","remote":"127.0.0.1:56736","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/edit\" "} {"level":"info","ts":"2026-09-18T15:16:24.062726Z","caller":"traceutil/trace.go:171","msg":"trace[1747016849] linearizableReadLoop","detail":"{readStateIndex:80; appliedIndex:79; }","duration":"174.271026ms","start":"2026-09-18T15:16:23.888418Z","end":"2026-09-18T15:16:24.062689Z","steps":["trace[1747016849] 'read index received' (duration: 102.758078ms)","trace[1747016849] 'applied index is now lower than readState.Index' (duration: 71.511318ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:16:24.062891Z","caller":"traceutil/trace.go:171","msg":"trace[1882142038] transaction","detail":"{read_only:false; response_revision:77; number_of_response:1; }","duration":"511.564473ms","start":"2026-09-18T15:16:23.551259Z","end":"2026-09-18T15:16:24.062823Z","steps":["trace[1882142038] 'process raft request' (duration: 440.016553ms)","trace[1882142038] 'compare' (duration: 71.200803ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:16:24.063074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.465226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-18T15:16:24.063139Z","caller":"traceutil/trace.go:171","msg":"trace[1685942382] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:77; }","duration":"474.586119ms","start":"2026-09-18T15:16:23.588535Z","end":"2026-09-18T15:16:24.063121Z","steps":["trace[1685942382] 'agreement among raft nodes before linearized reading' (duration: 474.407426ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:24.063148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.180416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-18T15:16:24.063182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:23.588509Z","time spent":"474.661369ms","remote":"127.0.0.1:56354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-18T15:16:24.063281Z","caller":"traceutil/trace.go:171","msg":"trace[986247623] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:77; }","duration":"171.353919ms","start":"2026-09-18T15:16:23.891885Z","end":"2026-09-18T15:16:24.063239Z","steps":["trace[986247623] 'agreement among raft nodes before linearized reading' (duration: 171.155215ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:24.063694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:16:23.55125Z","time spent":"511.703795ms","remote":"127.0.0.1:56566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3453,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T15:16:25.526283Z","caller":"traceutil/trace.go:171","msg":"trace[992254821] transaction","detail":"{read_only:false; response_revision:144; number_of_response:1; }","duration":"101.945846ms","start":"2026-09-18T15:16:25.424294Z","end":"2026-09-18T15:16:25.52624Z","steps":["trace[992254821] 'process raft request' (duration: 41.742022ms)","trace[992254821] 'compare' (duration: 59.937639ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:16:45.312147Z","caller":"traceutil/trace.go:171","msg":"trace[2015533885] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"117.032776ms","start":"2026-09-18T15:16:45.195059Z","end":"2026-09-18T15:16:45.312091Z","steps":["trace[2015533885] 'process raft request' (duration: 116.8398ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:16:47.433937Z","caller":"traceutil/trace.go:171","msg":"trace[1394637110] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"113.012752ms","start":"2026-09-18T15:16:47.320884Z","end":"2026-09-18T15:16:47.433897Z","steps":["trace[1394637110] 'process raft request' (duration: 112.740922ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:16:51.24456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.42949ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T15:16:51.244687Z","caller":"traceutil/trace.go:171","msg":"trace[1512313444] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"224.446981ms","start":"2026-09-18T15:16:51.020214Z","end":"2026-09-18T15:16:51.244661Z","steps":["trace[1512313444] 'process raft request' (duration: 109.6935ms)","trace[1512313444] 'compare' (duration: 114.273275ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:16:54.925303Z","caller":"traceutil/trace.go:171","msg":"trace[1388414350] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"102.819921ms","start":"2026-09-18T15:16:54.822413Z","end":"2026-09-18T15:16:54.925233Z","steps":["trace[1388414350] 'process raft request' (duration: 66.12203ms)","trace[1388414350] 'compare' (duration: 36.422341ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:16:54.92557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.798673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-09-18T15:16:54.925611Z","caller":"traceutil/trace.go:171","msg":"trace[154377709] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:460; }","duration":"116.893686ms","start":"2026-09-18T15:16:54.808705Z","end":"2026-09-18T15:16:54.925599Z","steps":["trace[154377709] 'agreement among raft nodes before linearized reading' (duration: 116.564354ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:14.647881Z","caller":"traceutil/trace.go:171","msg":"trace[1220250842] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"137.199334ms","start":"2026-09-18T15:17:14.51064Z","end":"2026-09-18T15:17:14.64784Z","steps":["trace[1220250842] 'process raft request' (duration: 130.844259ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:19.742226Z","caller":"traceutil/trace.go:171","msg":"trace[1169843183] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"203.833491ms","start":"2026-09-18T15:17:19.538362Z","end":"2026-09-18T15:17:19.742196Z","steps":["trace[1169843183] 'process raft request' (duration: 203.265994ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:22.164604Z","caller":"traceutil/trace.go:171","msg":"trace[847728597] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"404.5325ms","start":"2026-09-18T15:17:21.760042Z","end":"2026-09-18T15:17:22.164574Z","steps":["trace[847728597] 'process raft request' (duration: 404.376942ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:17:22.164939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:17:21.760032Z","time spent":"404.661987ms","remote":"127.0.0.1:56656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:17:22.297302Z","caller":"traceutil/trace.go:171","msg":"trace[289583489] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"537.06015ms","start":"2026-09-18T15:17:21.760193Z","end":"2026-09-18T15:17:22.297253Z","steps":["trace[289583489] 'process raft request' (duration: 530.709868ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:17:22.297547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:17:21.760143Z","time spent":"537.278172ms","remote":"127.0.0.1:56656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:17:22.297816Z","caller":"traceutil/trace.go:171","msg":"trace[1357034952] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"535.355877ms","start":"2026-09-18T15:17:21.762401Z","end":"2026-09-18T15:17:22.297757Z","steps":["trace[1357034952] 'process raft request' (duration: 534.78893ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:17:22.298117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:17:21.762384Z","time spent":"535.525106ms","remote":"127.0.0.1:56656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:17:22.299821Z","caller":"traceutil/trace.go:171","msg":"trace[2120971012] linearizableReadLoop","detail":"{readStateIndex:739; appliedIndex:736; }","duration":"205.185831ms","start":"2026-09-18T15:17:22.09458Z","end":"2026-09-18T15:17:22.299766Z","steps":["trace[2120971012] 'read index received' (duration: 69.967488ms)","trace[2120971012] 'applied index is now lower than readState.Index' (duration: 135.216813ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:17:22.300127Z","caller":"traceutil/trace.go:171","msg":"trace[1796579533] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"205.352489ms","start":"2026-09-18T15:17:22.09475Z","end":"2026-09-18T15:17:22.300103Z","steps":["trace[1796579533] 'process raft request' (duration: 203.621144ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:17:22.300388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.692955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-k75fg\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-18T15:17:22.300471Z","caller":"traceutil/trace.go:171","msg":"trace[398266536] range","detail":"{range_begin:/registry/pods/kube-system/cilium-k75fg; range_end:; response_count:1; response_revision:714; }","duration":"205.914526ms","start":"2026-09-18T15:17:22.094529Z","end":"2026-09-18T15:17:22.300443Z","steps":["trace[398266536] 'agreement among raft nodes before linearized reading' (duration: 205.548888ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:22.50087Z","caller":"traceutil/trace.go:171","msg":"trace[1894663521] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"184.227217ms","start":"2026-09-18T15:17:22.316588Z","end":"2026-09-18T15:17:22.500815Z","steps":["trace[1894663521] 'process raft request' (duration: 183.359465ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:22.515002Z","caller":"traceutil/trace.go:171","msg":"trace[1037352382] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"159.51564ms","start":"2026-09-18T15:17:22.355446Z","end":"2026-09-18T15:17:22.514962Z","steps":["trace[1037352382] 'process raft request' (duration: 159.170412ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:23.230567Z","caller":"traceutil/trace.go:171","msg":"trace[768202638] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"277.852558ms","start":"2026-09-18T15:17:22.95269Z","end":"2026-09-18T15:17:23.230543Z","steps":["trace[768202638] 'process raft request' (duration: 268.146236ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:17:41.746193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.262208ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T15:17:41.74638Z","caller":"traceutil/trace.go:171","msg":"trace[352710413] linearizableReadLoop","detail":"{readStateIndex:880; appliedIndex:879; }","duration":"151.761603ms","start":"2026-09-18T15:17:41.594597Z","end":"2026-09-18T15:17:41.746359Z","steps":["trace[352710413] 'read index received' (duration: 72.644µs)","trace[352710413] 'applied index is now lower than readState.Index' (duration: 151.687239ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:17:41.746565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.974484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-18T15:17:41.746509Z","caller":"traceutil/trace.go:171","msg":"trace[682404725] transaction","detail":"{read_only:false; response_revision:849; number_of_response:1; }","duration":"342.387406ms","start":"2026-09-18T15:17:41.404076Z","end":"2026-09-18T15:17:41.746463Z","steps":["trace[682404725] 'process raft request' (duration: 179.744366ms)","trace[682404725] 'compare' (duration: 162.019465ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:17:41.746889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:17:41.40405Z","time spent":"342.714383ms","remote":"127.0.0.1:56656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:17:41.746604Z","caller":"traceutil/trace.go:171","msg":"trace[761625922] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:849; }","duration":"152.050389ms","start":"2026-09-18T15:17:41.594543Z","end":"2026-09-18T15:17:41.746593Z","steps":["trace[761625922] 'agreement among raft nodes before linearized reading' (duration: 151.868519ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:48.684869Z","caller":"traceutil/trace.go:171","msg":"trace[1853104150] transaction","detail":"{read_only:false; response_revision:1639; number_of_response:1; }","duration":"117.467442ms","start":"2026-09-18T15:18:48.56737Z","end":"2026-09-18T15:18:48.684837Z","steps":["trace[1853104150] 'process raft request' (duration: 95.911717ms)","trace[1853104150] 'compare' (duration: 21.435738ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:19:10.822731Z","caller":"traceutil/trace.go:171","msg":"trace[484609779] transaction","detail":"{read_only:false; response_revision:1978; number_of_response:1; }","duration":"171.737881ms","start":"2026-09-18T15:19:10.650969Z","end":"2026-09-18T15:19:10.822707Z","steps":["trace[484609779] 'process raft request' (duration: 171.57461ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:19:11.512743Z","caller":"traceutil/trace.go:171","msg":"trace[215485482] linearizableReadLoop","detail":"{readStateIndex:2058; appliedIndex:2057; }","duration":"405.136649ms","start":"2026-09-18T15:19:11.107573Z","end":"2026-09-18T15:19:11.512709Z","steps":["trace[215485482] 'read index received' (duration: 404.922935ms)","trace[215485482] 'applied index is now lower than readState.Index' (duration: 212.044µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:19:11.513015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.409907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-09-18T15:19:11.513115Z","caller":"traceutil/trace.go:171","msg":"trace[1346776945] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1981; }","duration":"405.554276ms","start":"2026-09-18T15:19:11.107528Z","end":"2026-09-18T15:19:11.513083Z","steps":["trace[1346776945] 'agreement among raft nodes before linearized reading' (duration: 405.290489ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:19:11.51316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:11.107504Z","time spent":"405.647183ms","remote":"127.0.0.1:56656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-18T15:19:11.513371Z","caller":"traceutil/trace.go:171","msg":"trace[1591990900] transaction","detail":"{read_only:false; response_revision:1981; number_of_response:1; }","duration":"434.304901ms","start":"2026-09-18T15:19:11.07847Z","end":"2026-09-18T15:19:11.512775Z","steps":["trace[1591990900] 'process raft request' (duration: 434.020871ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:19:11.513484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:11.078437Z","time spent":"434.977855ms","remote":"127.0.0.1:56656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:19:11.544124Z","caller":"traceutil/trace.go:171","msg":"trace[714711701] transaction","detail":"{read_only:false; response_revision:1982; number_of_response:1; }","duration":"219.077859ms","start":"2026-09-18T15:19:11.325011Z","end":"2026-09-18T15:19:11.544089Z","steps":["trace[714711701] 'process raft request' (duration: 218.721175ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:19:11.544454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.437361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-25b5c039-afa4-4444-a9f5-b3629ecf007c\" ","response":"range_response_count:1 size:3743"} {"level":"info","ts":"2026-09-18T15:19:11.544583Z","caller":"traceutil/trace.go:171","msg":"trace[1422947398] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-25b5c039-afa4-4444-a9f5-b3629ecf007c; range_end:; response_count:1; response_revision:1983; }","duration":"372.594712ms","start":"2026-09-18T15:19:11.171941Z","end":"2026-09-18T15:19:11.544535Z","steps":["trace[1422947398] 'agreement among raft nodes before linearized reading' (duration: 372.278831ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:19:11.544631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:11.171919Z","time spent":"372.702448ms","remote":"127.0.0.1:56566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3765,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-25b5c039-afa4-4444-a9f5-b3629ecf007c\" "} {"level":"info","ts":"2026-09-18T15:19:26.355236Z","caller":"traceutil/trace.go:171","msg":"trace[5838938] linearizableReadLoop","detail":"{readStateIndex:2189; appliedIndex:2188; }","duration":"141.051323ms","start":"2026-09-18T15:19:26.214111Z","end":"2026-09-18T15:19:26.355162Z","steps":["trace[5838938] 'read index received' (duration: 140.615623ms)","trace[5838938] 'applied index is now lower than readState.Index' (duration: 433.2µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:19:26.355582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.439339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-09-18T15:19:26.355646Z","caller":"traceutil/trace.go:171","msg":"trace[1053064552] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2108; }","duration":"141.579899ms","start":"2026-09-18T15:19:26.214037Z","end":"2026-09-18T15:19:26.355617Z","steps":["trace[1053064552] 'agreement among raft nodes before linearized reading' (duration: 141.315221ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:19:46.128487Z","caller":"traceutil/trace.go:171","msg":"trace[1415932127] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"347.189272ms","start":"2026-09-18T15:19:45.78127Z","end":"2026-09-18T15:19:46.128459Z","steps":["trace[1415932127] 'process raft request' (duration: 347.030722ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:19:46.128707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:45.781244Z","time spent":"347.383507ms","remote":"127.0.0.1:56656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:19:46.150714Z","caller":"traceutil/trace.go:171","msg":"trace[1950281163] linearizableReadLoop","detail":"{readStateIndex:2308; appliedIndex:2306; }","duration":"234.48439ms","start":"2026-09-18T15:19:45.916207Z","end":"2026-09-18T15:19:46.150691Z","steps":["trace[1950281163] 'read index received' (duration: 212.181222ms)","trace[1950281163] 'applied index is now lower than readState.Index' (duration: 22.301798ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:19:46.150961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.731479ms","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-18T15:19:46.15099Z","caller":"traceutil/trace.go:171","msg":"trace[1033861836] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2224; }","duration":"234.818104ms","start":"2026-09-18T15:19:45.916161Z","end":"2026-09-18T15:19:46.150979Z","steps":["trace[1033861836] 'agreement among raft nodes before linearized reading' (duration: 234.62116ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:19:46.151341Z","caller":"traceutil/trace.go:171","msg":"trace[919692568] transaction","detail":"{read_only:false; response_revision:2223; number_of_response:1; }","duration":"367.479553ms","start":"2026-09-18T15:19:45.783815Z","end":"2026-09-18T15:19:46.151295Z","steps":["trace[919692568] 'process raft request' (duration: 366.70574ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:19:46.151426Z","caller":"traceutil/trace.go:171","msg":"trace[1368498045] transaction","detail":"{read_only:false; response_revision:2224; number_of_response:1; }","duration":"223.712514ms","start":"2026-09-18T15:19:45.927703Z","end":"2026-09-18T15:19:46.151416Z","steps":["trace[1368498045] 'process raft request' (duration: 222.951951ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:19:46.151917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:19:45.783804Z","time spent":"368.01501ms","remote":"127.0.0.1:56656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:19:46.435911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.08926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.54\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-18T15:19:46.436004Z","caller":"traceutil/trace.go:171","msg":"trace[570289624] range","detail":"{range_begin:/registry/masterleases/162.253.55.54; range_end:; response_count:1; response_revision:2224; }","duration":"239.287433ms","start":"2026-09-18T15:19:46.196697Z","end":"2026-09-18T15:19:46.435984Z","steps":["trace[570289624] 'range keys from in-memory index tree' (duration: 238.882826ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:21:29.057325Z","caller":"traceutil/trace.go:171","msg":"trace[1420540331] transaction","detail":"{read_only:false; response_revision:2886; number_of_response:1; }","duration":"107.136364ms","start":"2026-09-18T15:21:28.950159Z","end":"2026-09-18T15:21:29.057295Z","steps":["trace[1420540331] 'process raft request' (duration: 106.87297ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:21:29.294689Z","caller":"traceutil/trace.go:171","msg":"trace[2018528201] linearizableReadLoop","detail":"{readStateIndex:2995; appliedIndex:2994; }","duration":"168.913137ms","start":"2026-09-18T15:21:29.125727Z","end":"2026-09-18T15:21:29.294641Z","steps":["trace[2018528201] 'read index received' (duration: 148.234359ms)","trace[2018528201] 'applied index is now lower than readState.Index' (duration: 20.676918ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:21:29.29475Z","caller":"traceutil/trace.go:171","msg":"trace[1637579026] transaction","detail":"{read_only:false; response_revision:2887; number_of_response:1; }","duration":"228.20691ms","start":"2026-09-18T15:21:29.066505Z","end":"2026-09-18T15:21:29.294712Z","steps":["trace[1637579026] 'process raft request' (duration: 207.41242ms)","trace[1637579026] 'compare' (duration: 20.538577ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:21:29.295059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.639811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-09-18T15:21:29.29509Z","caller":"traceutil/trace.go:171","msg":"trace[2104497185] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2887; }","duration":"147.739652ms","start":"2026-09-18T15:21:29.147341Z","end":"2026-09-18T15:21:29.29508Z","steps":["trace[2104497185] 'agreement among raft nodes before linearized reading' (duration: 147.598671ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:21:29.29511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.349052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-09-18T15:21:29.295162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.571059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:21:29.295161Z","caller":"traceutil/trace.go:171","msg":"trace[1074351336] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2887; }","duration":"169.479213ms","start":"2026-09-18T15:21:29.125669Z","end":"2026-09-18T15:21:29.295148Z","steps":["trace[1074351336] 'agreement among raft nodes before linearized reading' (duration: 169.24575ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:21:29.295183Z","caller":"traceutil/trace.go:171","msg":"trace[524711344] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:2887; }","duration":"107.6347ms","start":"2026-09-18T15:21:29.187541Z","end":"2026-09-18T15:21:29.295176Z","steps":["trace[524711344] 'agreement among raft nodes before linearized reading' (duration: 107.59708ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:21:29.295717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.210358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-18T15:21:29.295812Z","caller":"traceutil/trace.go:171","msg":"trace[1028614719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2887; }","duration":"148.38207ms","start":"2026-09-18T15:21:29.147408Z","end":"2026-09-18T15:21:29.29579Z","steps":["trace[1028614719] 'agreement among raft nodes before linearized reading' (duration: 147.970565ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:26:10.433098Z","caller":"traceutil/trace.go:171","msg":"trace[2093276032] transaction","detail":"{read_only:false; response_revision:5055; number_of_response:1; }","duration":"131.392322ms","start":"2026-09-18T15:26:10.301692Z","end":"2026-09-18T15:26:10.433084Z","steps":["trace[2093276032] 'process raft request' (duration: 128.912369ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:26:17.135532Z","caller":"traceutil/trace.go:171","msg":"trace[1785315934] transaction","detail":"{read_only:false; response_revision:5152; number_of_response:1; }","duration":"265.31242ms","start":"2026-09-18T15:26:16.870191Z","end":"2026-09-18T15:26:17.135503Z","steps":["trace[1785315934] 'process raft request' (duration: 265.085788ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:26:17.33906Z","caller":"traceutil/trace.go:171","msg":"trace[1716551794] transaction","detail":"{read_only:false; response_revision:5153; number_of_response:1; }","duration":"465.89177ms","start":"2026-09-18T15:26:16.873124Z","end":"2026-09-18T15:26:17.339016Z","steps":["trace[1716551794] 'process raft request' (duration: 375.998574ms)","trace[1716551794] 'compare' (duration: 89.480354ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:26:17.339447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:26:16.873097Z","time spent":"466.041528ms","remote":"127.0.0.1:56454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T15:26:17.33918Z","caller":"traceutil/trace.go:171","msg":"trace[307953411] linearizableReadLoop","detail":"{readStateIndex:5350; appliedIndex:5348; }","duration":"398.904889ms","start":"2026-09-18T15:26:16.940152Z","end":"2026-09-18T15:26:17.339057Z","steps":["trace[307953411] 'read index received' (duration: 195.088905ms)","trace[307953411] 'applied index is now lower than readState.Index' (duration: 203.813554ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:26:17.339705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.500601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fe4e4e0e-b7b5-4fcf-9bde-9f9b35634451\" ","response":"range_response_count:1 size:3765"} {"level":"info","ts":"2026-09-18T15:26:17.339818Z","caller":"traceutil/trace.go:171","msg":"trace[74456077] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fe4e4e0e-b7b5-4fcf-9bde-9f9b35634451; range_end:; response_count:1; response_revision:5153; }","duration":"399.697621ms","start":"2026-09-18T15:26:16.940102Z","end":"2026-09-18T15:26:17.3398Z","steps":["trace[74456077] 'agreement among raft nodes before linearized reading' (duration: 399.306759ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:26:17.339896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.528022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:26:17.339954Z","caller":"traceutil/trace.go:171","msg":"trace[104450072] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:5153; }","duration":"399.589885ms","start":"2026-09-18T15:26:16.940345Z","end":"2026-09-18T15:26:17.339935Z","steps":["trace[104450072] 'agreement among raft nodes before linearized reading' (duration: 399.4939ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:26:17.340017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:26:16.940296Z","time spent":"399.705822ms","remote":"127.0.0.1:60302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true "} {"level":"warn","ts":"2026-09-18T15:26:17.340035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.684574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-18T15:26:17.340081Z","caller":"traceutil/trace.go:171","msg":"trace[1852405795] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5153; }","duration":"239.776139ms","start":"2026-09-18T15:26:17.100292Z","end":"2026-09-18T15:26:17.340068Z","steps":["trace[1852405795] 'agreement among raft nodes before linearized reading' (duration: 239.656243ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:26:17.339896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:26:16.940075Z","time spent":"399.805788ms","remote":"127.0.0.1:56566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3787,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fe4e4e0e-b7b5-4fcf-9bde-9f9b35634451\" "} {"level":"warn","ts":"2026-09-18T15:26:17.340212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.218984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-18T15:26:17.340274Z","caller":"traceutil/trace.go:171","msg":"trace[1579784892] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5153; }","duration":"261.321129ms","start":"2026-09-18T15:26:17.078938Z","end":"2026-09-18T15:26:17.340259Z","steps":["trace[1579784892] 'agreement among raft nodes before linearized reading' (duration: 261.098597ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:26:17.340519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.074834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-574c7b8f7b-jqjdd\" ","response":"range_response_count:1 size:11256"} {"level":"info","ts":"2026-09-18T15:26:17.34059Z","caller":"traceutil/trace.go:171","msg":"trace[372612289] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-574c7b8f7b-jqjdd; range_end:; response_count:1; response_revision:5153; }","duration":"200.164608ms","start":"2026-09-18T15:26:17.14039Z","end":"2026-09-18T15:26:17.340555Z","steps":["trace[372612289] 'agreement among raft nodes before linearized reading' (duration: 200.032701ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:26:17.34165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.685849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-18T15:26:17.341716Z","caller":"traceutil/trace.go:171","msg":"trace[1370405215] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5153; }","duration":"243.775764ms","start":"2026-09-18T15:26:17.097924Z","end":"2026-09-18T15:26:17.341699Z","steps":["trace[1370405215] 'agreement among raft nodes before linearized reading' (duration: 242.02782ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:26:17.513167Z","caller":"traceutil/trace.go:171","msg":"trace[1556880843] transaction","detail":"{read_only:false; response_revision:5157; number_of_response:1; }","duration":"141.337582ms","start":"2026-09-18T15:26:17.371789Z","end":"2026-09-18T15:26:17.513126Z","steps":["trace[1556880843] 'process raft request' (duration: 91.28235ms)","trace[1556880843] 'compare' (duration: 49.857482ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:26:17.830224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.866176ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T15:26:17.830466Z","caller":"traceutil/trace.go:171","msg":"trace[20117773] transaction","detail":"{read_only:false; response_revision:5159; number_of_response:1; }","duration":"307.753556ms","start":"2026-09-18T15:26:17.522686Z","end":"2026-09-18T15:26:17.83044Z","steps":["trace[20117773] 'process raft request' (duration: 201.558863ms)","trace[20117773] 'compare' (duration: 105.685476ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:26:17.830545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:26:17.522656Z","time spent":"307.856422ms","remote":"127.0.0.1:56542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:26:17.830676Z","caller":"traceutil/trace.go:171","msg":"trace[1220832495] linearizableReadLoop","detail":"{readStateIndex:5356; appliedIndex:5354; }","duration":"272.954674ms","start":"2026-09-18T15:26:17.557703Z","end":"2026-09-18T15:26:17.830658Z","steps":["trace[1220832495] 'read index received' (duration: 34.7694ms)","trace[1220832495] 'applied index is now lower than readState.Index' (duration: 238.183954ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:26:17.830791Z","caller":"traceutil/trace.go:171","msg":"trace[1178475997] transaction","detail":"{read_only:false; response_revision:5160; number_of_response:1; }","duration":"264.332049ms","start":"2026-09-18T15:26:17.566445Z","end":"2026-09-18T15:26:17.830777Z","steps":["trace[1178475997] 'process raft request' (duration: 263.931598ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:26:17.831087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.326229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T15:26:17.831181Z","caller":"traceutil/trace.go:171","msg":"trace[1631692957] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5160; }","duration":"245.481097ms","start":"2026-09-18T15:26:17.585687Z","end":"2026-09-18T15:26:17.831168Z","steps":["trace[1631692957] 'agreement among raft nodes before linearized reading' (duration: 245.304768ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:26:17.831115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.409049ms","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-18T15:26:17.831314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.903286ms","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-18T15:26:17.831406Z","caller":"traceutil/trace.go:171","msg":"trace[1682230235] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5160; }","duration":"145.084146ms","start":"2026-09-18T15:26:17.686307Z","end":"2026-09-18T15:26:17.831391Z","steps":["trace[1682230235] 'agreement among raft nodes before linearized reading' (duration: 144.773189ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:26:17.831407Z","caller":"traceutil/trace.go:171","msg":"trace[1700150963] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5160; }","duration":"273.734837ms","start":"2026-09-18T15:26:17.557638Z","end":"2026-09-18T15:26:17.831372Z","steps":["trace[1700150963] 'agreement among raft nodes before linearized reading' (duration: 273.428421ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:26:18.045767Z","caller":"traceutil/trace.go:171","msg":"trace[234509959] transaction","detail":"{read_only:false; response_revision:5163; number_of_response:1; }","duration":"106.613137ms","start":"2026-09-18T15:26:17.939115Z","end":"2026-09-18T15:26:18.045728Z","steps":["trace[234509959] 'process raft request' (duration: 92.334999ms)","trace[234509959] 'compare' (duration: 14.013564ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:26:20.006182Z","caller":"traceutil/trace.go:171","msg":"trace[686867258] linearizableReadLoop","detail":"{readStateIndex:5391; appliedIndex:5390; }","duration":"103.769051ms","start":"2026-09-18T15:26:19.902378Z","end":"2026-09-18T15:26:20.006147Z","steps":["trace[686867258] 'read index received' (duration: 103.433333ms)","trace[686867258] 'applied index is now lower than readState.Index' (duration: 330.447µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:26:20.006226Z","caller":"traceutil/trace.go:171","msg":"trace[510016042] transaction","detail":"{read_only:false; response_revision:5194; number_of_response:1; }","duration":"122.923593ms","start":"2026-09-18T15:26:19.883262Z","end":"2026-09-18T15:26:20.006185Z","steps":["trace[510016042] 'process raft request' (duration: 122.634137ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:26:20.006504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.096999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-vv4jq.18d673c01922a511\" ","response":"range_response_count:1 size:962"} {"level":"info","ts":"2026-09-18T15:26:20.006555Z","caller":"traceutil/trace.go:171","msg":"trace[650426703] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-vv4jq.18d673c01922a511; range_end:; response_count:1; response_revision:5194; }","duration":"104.218185ms","start":"2026-09-18T15:26:19.902322Z","end":"2026-09-18T15:26:20.00654Z","steps":["trace[650426703] 'agreement among raft nodes before linearized reading' (duration: 103.974882ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:26:21.100191Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2846} {"level":"info","ts":"2026-09-18T15:26:21.176234Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2846,"took":"74.12521ms","hash":658090969,"current-db-size-bytes":50835456,"current-db-size":"51 MB","current-db-size-in-use-bytes":27168768,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-18T15:26:21.176318Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":658090969,"revision":2846,"compact-revision":-1} {"level":"warn","ts":"2026-09-18T15:26:30.792788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.186346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:26:30.792879Z","caller":"traceutil/trace.go:171","msg":"trace[245852999] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:5320; }","duration":"123.337465ms","start":"2026-09-18T15:26:30.669519Z","end":"2026-09-18T15:26:30.792856Z","steps":["trace[245852999] 'count revisions from in-memory index tree' (duration: 123.026918ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:26:31.11781Z","caller":"traceutil/trace.go:171","msg":"trace[111361400] linearizableReadLoop","detail":"{readStateIndex:5524; appliedIndex:5523; }","duration":"195.694565ms","start":"2026-09-18T15:26:30.922094Z","end":"2026-09-18T15:26:31.117789Z","steps":["trace[111361400] 'read index received' (duration: 195.557948ms)","trace[111361400] 'applied index is now lower than readState.Index' (duration: 134.907µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:26:31.117891Z","caller":"traceutil/trace.go:171","msg":"trace[1622521210] transaction","detail":"{read_only:false; response_revision:5321; number_of_response:1; }","duration":"200.233122ms","start":"2026-09-18T15:26:30.917621Z","end":"2026-09-18T15:26:31.117854Z","steps":["trace[1622521210] 'process raft request' (duration: 199.985359ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:26:31.118039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.889247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10394"} {"level":"info","ts":"2026-09-18T15:26:31.118079Z","caller":"traceutil/trace.go:171","msg":"trace[1311404468] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5321; }","duration":"137.982103ms","start":"2026-09-18T15:26:30.980084Z","end":"2026-09-18T15:26:31.118067Z","steps":["trace[1311404468] 'agreement among raft nodes before linearized reading' (duration: 137.823005ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:26:31.11808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.95785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9637"} {"level":"info","ts":"2026-09-18T15:26:31.118159Z","caller":"traceutil/trace.go:171","msg":"trace[1550939709] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:5321; }","duration":"196.081486ms","start":"2026-09-18T15:26:30.922063Z","end":"2026-09-18T15:26:31.118145Z","steps":["trace[1550939709] 'agreement among raft nodes before linearized reading' (duration: 195.797651ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:26:31.562535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.903251ms","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-18T15:26:31.562562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.159562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:26:31.5626Z","caller":"traceutil/trace.go:171","msg":"trace[1011381645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5328; }","duration":"113.028459ms","start":"2026-09-18T15:26:31.449556Z","end":"2026-09-18T15:26:31.562585Z","steps":["trace[1011381645] 'range keys from in-memory index tree' (duration: 112.714581ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:26:31.562647Z","caller":"traceutil/trace.go:171","msg":"trace[668646350] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5328; }","duration":"103.28565ms","start":"2026-09-18T15:26:31.459338Z","end":"2026-09-18T15:26:31.562624Z","steps":["trace[668646350] 'range keys from in-memory index tree' (duration: 102.967902ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:30:51.760491Z","caller":"traceutil/trace.go:171","msg":"trace[226807409] transaction","detail":"{read_only:false; response_revision:7209; number_of_response:1; }","duration":"110.689398ms","start":"2026-09-18T15:30:51.649771Z","end":"2026-09-18T15:30:51.760461Z","steps":["trace[226807409] 'process raft request' (duration: 110.513947ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:30:51.761089Z","caller":"traceutil/trace.go:171","msg":"trace[1671157665] linearizableReadLoop","detail":"{readStateIndex:7472; appliedIndex:7471; }","duration":"113.632866ms","start":"2026-09-18T15:30:51.647438Z","end":"2026-09-18T15:30:51.761071Z","steps":["trace[1671157665] 'read index received' (duration: 64.700768ms)","trace[1671157665] 'applied index is now lower than readState.Index' (duration: 48.929898ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:30:51.829701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.006877ms","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-18T15:30:51.830086Z","caller":"traceutil/trace.go:171","msg":"trace[872365342] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7209; }","duration":"120.463482ms","start":"2026-09-18T15:30:51.709604Z","end":"2026-09-18T15:30:51.830067Z","steps":["trace[872365342] 'agreement among raft nodes before linearized reading' (duration: 51.601144ms)","trace[872365342] 'range keys from in-memory index tree' (duration: 68.395904ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:30:51.829818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.371554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-09-18T15:30:51.830244Z","caller":"traceutil/trace.go:171","msg":"trace[1315567201] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:7209; }","duration":"182.807357ms","start":"2026-09-18T15:30:51.64738Z","end":"2026-09-18T15:30:51.830187Z","steps":["trace[1315567201] 'agreement among raft nodes before linearized reading' (duration: 113.806608ms)","trace[1315567201] 'range keys from in-memory index tree' (duration: 68.513955ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:31:21.10872Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5205} {"level":"info","ts":"2026-09-18T15:31:21.184287Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5205,"took":"74.10347ms","hash":3720204038,"current-db-size-bytes":50835456,"current-db-size":"51 MB","current-db-size-in-use-bytes":19402752,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-18T15:31:21.184374Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3720204038,"revision":5205,"compact-revision":2846}