{"level":"warn","ts":"2026-03-07T21:39:54.733657Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-07T21:39:54.7338Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.52: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.52:2380","--initial-cluster=instance=https://162.253.55.52:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.52:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.52: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-03-07T21:39:54.73391Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-07T21:39:54.733928Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.52:2380"]} {"level":"info","ts":"2026-03-07T21:39:54.733952Z","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-03-07T21:39:54.734839Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"]} {"level":"info","ts":"2026-03-07T21:39:54.734936Z","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.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.52: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-03-07T21:39:54.739025Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.814422ms"} {"level":"info","ts":"2026-03-07T21:39:54.746368Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b11e7fc5714be64b","cluster-id":"9349e4f32a52a90a"} {"level":"info","ts":"2026-03-07T21:39:54.746462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=()"} {"level":"info","ts":"2026-03-07T21:39:54.746492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 0"} {"level":"info","ts":"2026-03-07T21:39:54.746504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b11e7fc5714be64b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-07T21:39:54.746517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 1"} {"level":"info","ts":"2026-03-07T21:39:54.746558Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"} {"level":"warn","ts":"2026-03-07T21:39:54.755609Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-07T21:39:54.757447Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-07T21:39:54.758816Z","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-03-07T21:39:54.76171Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b11e7fc5714be64b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-07T21:39:54.762557Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b11e7fc5714be64b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-07T21:39:54.762946Z","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-03-07T21:39:54.76306Z","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-03-07T21:39:54.763078Z","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-03-07T21:39:54.763397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"} {"level":"info","ts":"2026-03-07T21:39:54.763682Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","added-peer-id":"b11e7fc5714be64b","added-peer-peer-urls":["https://162.253.55.52:2380"]} {"level":"info","ts":"2026-03-07T21:39:54.769332Z","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-03-07T21:39:54.769576Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b11e7fc5714be64b","initial-advertise-peer-urls":["https://162.253.55.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-07T21:39:54.769611Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-07T21:39:54.769729Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.52:2380"} {"level":"info","ts":"2026-03-07T21:39:54.769746Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.52:2380"} {"level":"info","ts":"2026-03-07T21:39:55.747575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b is starting a new election at term 1"} {"level":"info","ts":"2026-03-07T21:39:55.74772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became pre-candidate at term 1"} {"level":"info","ts":"2026-03-07T21:39:55.747785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgPreVoteResp from b11e7fc5714be64b at term 1"} {"level":"info","ts":"2026-03-07T21:39:55.747808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became candidate at term 2"} {"level":"info","ts":"2026-03-07T21:39:55.747827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgVoteResp from b11e7fc5714be64b at term 2"} {"level":"info","ts":"2026-03-07T21:39:55.747843Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became leader at term 2"} {"level":"info","ts":"2026-03-07T21:39:55.747868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b11e7fc5714be64b elected leader b11e7fc5714be64b at term 2"} {"level":"info","ts":"2026-03-07T21:39:55.749241Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b11e7fc5714be64b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.52:2379]}","request-path":"/0/members/b11e7fc5714be64b/attributes","cluster-id":"9349e4f32a52a90a","publish-timeout":"7s"} {"level":"info","ts":"2026-03-07T21:39:55.749264Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-07T21:39:55.749282Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-07T21:39:55.749369Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-07T21:39:55.749584Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-07T21:39:55.749609Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-07T21:39:55.75061Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","cluster-version":"3.5"} {"level":"info","ts":"2026-03-07T21:39:55.750747Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-07T21:39:55.750884Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-07T21:39:55.75267Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.52:2379"} {"level":"info","ts":"2026-03-07T21:39:55.753606Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-07T21:39:58.656028Z","caller":"traceutil/trace.go:171","msg":"trace[424559351] transaction","detail":"{read_only:false; response_revision:146; number_of_response:1; }","duration":"103.120647ms","start":"2026-03-07T21:39:58.552869Z","end":"2026-03-07T21:39:58.65599Z","steps":["trace[424559351] 'process raft request' (duration: 98.917505ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:40:13.518971Z","caller":"traceutil/trace.go:171","msg":"trace[570620277] linearizableReadLoop","detail":"{readStateIndex:416; appliedIndex:415; }","duration":"240.846315ms","start":"2026-03-07T21:40:13.278085Z","end":"2026-03-07T21:40:13.518931Z","steps":["trace[570620277] 'read index received' (duration: 240.570808ms)","trace[570620277] 'applied index is now lower than readState.Index' (duration: 273.417µs)"],"step_count":2} {"level":"info","ts":"2026-03-07T21:40:13.519017Z","caller":"traceutil/trace.go:171","msg":"trace[432005966] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"317.230121ms","start":"2026-03-07T21:40:13.201744Z","end":"2026-03-07T21:40:13.518974Z","steps":["trace[432005966] 'process raft request' (duration: 316.958494ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:40:13.519229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.118572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-03-07T21:40:13.519309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.492207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-07T21:40:13.519369Z","caller":"traceutil/trace.go:171","msg":"trace[830161981] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:405; }","duration":"132.660911ms","start":"2026-03-07T21:40:13.38669Z","end":"2026-03-07T21:40:13.519351Z","steps":["trace[830161981] 'agreement among raft nodes before linearized reading' (duration: 132.509857ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:40:13.519371Z","caller":"traceutil/trace.go:171","msg":"trace[1408147911] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:405; }","duration":"241.322157ms","start":"2026-03-07T21:40:13.278025Z","end":"2026-03-07T21:40:13.519347Z","steps":["trace[1408147911] 'agreement among raft nodes before linearized reading' (duration: 241.06005ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:40:13.519822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T21:40:13.201724Z","time spent":"317.465427ms","remote":"127.0.0.1:45138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7087,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-07T21:40:13.965708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.017837ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-07T21:40:13.965931Z","caller":"traceutil/trace.go:171","msg":"trace[2070801755] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"441.60966ms","start":"2026-03-07T21:40:13.524291Z","end":"2026-03-07T21:40:13.965901Z","steps":["trace[2070801755] 'process raft request' (duration: 287.121751ms)","trace[2070801755] 'compare' (duration: 153.886053ms)"],"step_count":2} {"level":"info","ts":"2026-03-07T21:40:13.965922Z","caller":"traceutil/trace.go:171","msg":"trace[980857262] linearizableReadLoop","detail":"{readStateIndex:418; appliedIndex:416; }","duration":"257.270547ms","start":"2026-03-07T21:40:13.708631Z","end":"2026-03-07T21:40:13.965902Z","steps":["trace[980857262] 'read index received' (duration: 102.949592ms)","trace[980857262] 'applied index is now lower than readState.Index' (duration: 154.319515ms)"],"step_count":2} {"level":"warn","ts":"2026-03-07T21:40:13.966086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T21:40:13.524263Z","time spent":"441.758153ms","remote":"127.0.0.1:45236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-07T21:40:13.96606Z","caller":"traceutil/trace.go:171","msg":"trace[1816555656] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"441.315932ms","start":"2026-03-07T21:40:13.52467Z","end":"2026-03-07T21:40:13.965985Z","steps":["trace[1816555656] 'process raft request' (duration: 441.164138ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:40:13.966125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.482752ms","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-03-07T21:40:13.966252Z","caller":"traceutil/trace.go:171","msg":"trace[2119721331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:407; }","duration":"257.639557ms","start":"2026-03-07T21:40:13.708594Z","end":"2026-03-07T21:40:13.966233Z","steps":["trace[2119721331] 'agreement among raft nodes before linearized reading' (duration: 257.422751ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:40:13.966291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T21:40:13.524646Z","time spent":"441.522287ms","remote":"127.0.0.1:45236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-07T21:40:30.814475Z","caller":"traceutil/trace.go:171","msg":"trace[1429821015] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"103.695642ms","start":"2026-03-07T21:40:30.710748Z","end":"2026-03-07T21:40:30.814443Z","steps":["trace[1429821015] 'process raft request' (duration: 103.523498ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:40:30.950266Z","caller":"traceutil/trace.go:171","msg":"trace[229938423] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"226.222325ms","start":"2026-03-07T21:40:30.724009Z","end":"2026-03-07T21:40:30.950231Z","steps":["trace[229938423] 'process raft request' (duration: 195.863022ms)","trace[229938423] 'compare' (duration: 30.256271ms)"],"step_count":2} {"level":"info","ts":"2026-03-07T21:40:31.492591Z","caller":"traceutil/trace.go:171","msg":"trace[1649615342] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"199.859411ms","start":"2026-03-07T21:40:31.29271Z","end":"2026-03-07T21:40:31.492569Z","steps":["trace[1649615342] 'process raft request' (duration: 199.749888ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:40:31.735072Z","caller":"traceutil/trace.go:171","msg":"trace[1346782715] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"437.633837ms","start":"2026-03-07T21:40:31.297409Z","end":"2026-03-07T21:40:31.735043Z","steps":["trace[1346782715] 'process raft request' (duration: 437.117124ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:40:31.735226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T21:40:31.297392Z","time spent":"437.748611ms","remote":"127.0.0.1:45124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4748,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-07T21:40:32.965223Z","caller":"traceutil/trace.go:171","msg":"trace[1756430789] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"115.871612ms","start":"2026-03-07T21:40:32.849321Z","end":"2026-03-07T21:40:32.965192Z","steps":["trace[1756430789] 'process raft request' (duration: 115.739808ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:40:32.965444Z","caller":"traceutil/trace.go:171","msg":"trace[237384064] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"116.13666ms","start":"2026-03-07T21:40:32.849292Z","end":"2026-03-07T21:40:32.965429Z","steps":["trace[237384064] 'process raft request' (duration: 73.191975ms)","trace[237384064] 'compare' (duration: 42.405379ms)"],"step_count":2} {"level":"info","ts":"2026-03-07T21:40:32.965691Z","caller":"traceutil/trace.go:171","msg":"trace[1876829460] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"115.0632ms","start":"2026-03-07T21:40:32.850597Z","end":"2026-03-07T21:40:32.96566Z","steps":["trace[1876829460] 'process raft request' (duration: 114.549215ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:40:32.965829Z","caller":"traceutil/trace.go:171","msg":"trace[1020807795] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"114.948027ms","start":"2026-03-07T21:40:32.850854Z","end":"2026-03-07T21:40:32.965802Z","steps":["trace[1020807795] 'process raft request' (duration: 114.328479ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:40:32.965897Z","caller":"traceutil/trace.go:171","msg":"trace[234097177] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"100.411673ms","start":"2026-03-07T21:40:32.865464Z","end":"2026-03-07T21:40:32.965876Z","steps":["trace[234097177] 'process raft request' (duration: 99.801816ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:40:32.965914Z","caller":"traceutil/trace.go:171","msg":"trace[1838682760] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"115.606916ms","start":"2026-03-07T21:40:32.850296Z","end":"2026-03-07T21:40:32.965903Z","steps":["trace[1838682760] 'process raft request' (duration: 114.813243ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:40:58.217759Z","caller":"traceutil/trace.go:171","msg":"trace[1658738301] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"304.399565ms","start":"2026-03-07T21:40:57.913332Z","end":"2026-03-07T21:40:58.217732Z","steps":["trace[1658738301] 'process raft request' (duration: 304.19717ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:40:58.217937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T21:40:57.913315Z","time spent":"304.534319ms","remote":"127.0.0.1:45114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1067,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-07T21:41:55.496129Z","caller":"traceutil/trace.go:171","msg":"trace[1730649428] linearizableReadLoop","detail":"{readStateIndex:1652; appliedIndex:1651; }","duration":"262.772778ms","start":"2026-03-07T21:41:55.233319Z","end":"2026-03-07T21:41:55.496091Z","steps":["trace[1730649428] 'read index received' (duration: 262.483171ms)","trace[1730649428] 'applied index is now lower than readState.Index' (duration: 288.247µs)"],"step_count":2} {"level":"info","ts":"2026-03-07T21:41:55.496335Z","caller":"traceutil/trace.go:171","msg":"trace[1038645263] transaction","detail":"{read_only:false; response_revision:1590; number_of_response:1; }","duration":"332.464569ms","start":"2026-03-07T21:41:55.163767Z","end":"2026-03-07T21:41:55.496231Z","steps":["trace[1038645263] 'process raft request' (duration: 332.11568ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:41:55.496549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.196739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-03-07T21:41:55.496601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T21:41:55.163744Z","time spent":"332.712695ms","remote":"127.0.0.1:45138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-07T21:41:55.496656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.381949ms","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-03-07T21:41:55.496662Z","caller":"traceutil/trace.go:171","msg":"trace[309793895] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1590; }","duration":"263.371704ms","start":"2026-03-07T21:41:55.233256Z","end":"2026-03-07T21:41:55.496627Z","steps":["trace[309793895] 'agreement among raft nodes before linearized reading' (duration: 263.148248ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:41:55.496705Z","caller":"traceutil/trace.go:171","msg":"trace[1321602575] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1590; }","duration":"243.464322ms","start":"2026-03-07T21:41:55.253227Z","end":"2026-03-07T21:41:55.496691Z","steps":["trace[1321602575] 'agreement among raft nodes before linearized reading' (duration: 243.228415ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:41:55.870759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.468259ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-07T21:41:55.870924Z","caller":"traceutil/trace.go:171","msg":"trace[337663188] linearizableReadLoop","detail":"{readStateIndex:1654; appliedIndex:1653; }","duration":"261.436341ms","start":"2026-03-07T21:41:55.609465Z","end":"2026-03-07T21:41:55.870901Z","steps":["trace[337663188] 'read index received' (duration: 16.601343ms)","trace[337663188] 'applied index is now lower than readState.Index' (duration: 244.833578ms)"],"step_count":2} {"level":"info","ts":"2026-03-07T21:41:55.870988Z","caller":"traceutil/trace.go:171","msg":"trace[950253769] transaction","detail":"{read_only:false; response_revision:1592; number_of_response:1; }","duration":"360.71885ms","start":"2026-03-07T21:41:55.51022Z","end":"2026-03-07T21:41:55.870938Z","steps":["trace[950253769] 'process raft request' (duration: 115.950313ms)","trace[950253769] 'compare' (duration: 244.278734ms)"],"step_count":2} {"level":"warn","ts":"2026-03-07T21:41:55.871129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.640892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-07T21:41:55.871206Z","caller":"traceutil/trace.go:171","msg":"trace[305577919] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1592; }","duration":"171.774346ms","start":"2026-03-07T21:41:55.699414Z","end":"2026-03-07T21:41:55.871188Z","steps":["trace[305577919] 'agreement among raft nodes before linearized reading' (duration: 171.636482ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:41:55.871198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T21:41:55.510157Z","time spent":"360.936566ms","remote":"127.0.0.1:45138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10966,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-07T21:41:55.871283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.799571ms","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-03-07T21:41:55.871381Z","caller":"traceutil/trace.go:171","msg":"trace[1781825028] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1592; }","duration":"261.973005ms","start":"2026-03-07T21:41:55.609385Z","end":"2026-03-07T21:41:55.871358Z","steps":["trace[1781825028] 'agreement among raft nodes before linearized reading' (duration: 261.649366ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:41:55.983948Z","caller":"traceutil/trace.go:171","msg":"trace[1117427167] transaction","detail":"{read_only:false; response_revision:1594; number_of_response:1; }","duration":"106.470725ms","start":"2026-03-07T21:41:55.877454Z","end":"2026-03-07T21:41:55.983925Z","steps":["trace[1117427167] 'process raft request' (duration: 98.55625ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:41:55.98426Z","caller":"traceutil/trace.go:171","msg":"trace[1830881858] transaction","detail":"{read_only:false; response_revision:1595; number_of_response:1; }","duration":"106.658449ms","start":"2026-03-07T21:41:55.877577Z","end":"2026-03-07T21:41:55.984235Z","steps":["trace[1830881858] 'process raft request' (duration: 106.290709ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:41:55.984406Z","caller":"traceutil/trace.go:171","msg":"trace[1881562259] transaction","detail":"{read_only:false; response_revision:1597; number_of_response:1; }","duration":"106.214406ms","start":"2026-03-07T21:41:55.878132Z","end":"2026-03-07T21:41:55.984346Z","steps":["trace[1881562259] 'process raft request' (duration: 106.178905ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:41:55.984509Z","caller":"traceutil/trace.go:171","msg":"trace[59316739] transaction","detail":"{read_only:false; response_revision:1596; number_of_response:1; }","duration":"106.556418ms","start":"2026-03-07T21:41:55.87793Z","end":"2026-03-07T21:41:55.984487Z","steps":["trace[59316739] 'process raft request' (duration: 106.081944ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:42:09.706748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.864415ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-07T21:42:09.706942Z","caller":"traceutil/trace.go:171","msg":"trace[75318591] transaction","detail":"{read_only:false; response_revision:1711; number_of_response:1; }","duration":"123.391895ms","start":"2026-03-07T21:42:09.583515Z","end":"2026-03-07T21:42:09.706907Z","steps":["trace[75318591] 'process raft request' (duration: 16.265743ms)","trace[75318591] 'compare' (duration: 106.712471ms)"],"step_count":2} {"level":"warn","ts":"2026-03-07T21:42:12.81193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.757165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-03-07T21:42:12.811979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.391402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-03-07T21:42:12.812001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.962995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-03-07T21:42:12.812032Z","caller":"traceutil/trace.go:171","msg":"trace[9865285] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1727; }","duration":"156.898159ms","start":"2026-03-07T21:42:12.655105Z","end":"2026-03-07T21:42:12.812003Z","steps":["trace[9865285] 'range keys from in-memory index tree' (duration: 156.587921ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:42:12.812071Z","caller":"traceutil/trace.go:171","msg":"trace[1581457816] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1727; }","duration":"159.104899ms","start":"2026-03-07T21:42:12.652949Z","end":"2026-03-07T21:42:12.812054Z","steps":["trace[1581457816] 'range keys from in-memory index tree' (duration: 158.799161ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:42:12.812062Z","caller":"traceutil/trace.go:171","msg":"trace[722458885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1727; }","duration":"154.499804ms","start":"2026-03-07T21:42:12.657539Z","end":"2026-03-07T21:42:12.812039Z","steps":["trace[722458885] 'range keys from in-memory index tree' (duration: 154.253478ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:42:12.812081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.821792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-07T21:42:12.812213Z","caller":"traceutil/trace.go:171","msg":"trace[2016672396] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1727; }","duration":"115.013487ms","start":"2026-03-07T21:42:12.697171Z","end":"2026-03-07T21:42:12.812184Z","steps":["trace[2016672396] 'range keys from in-memory index tree' (duration: 114.718749ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:42:52.399518Z","caller":"traceutil/trace.go:171","msg":"trace[805947946] transaction","detail":"{read_only:false; response_revision:1921; number_of_response:1; }","duration":"120.344195ms","start":"2026-03-07T21:42:52.279151Z","end":"2026-03-07T21:42:52.399496Z","steps":["trace[805947946] 'process raft request' (duration: 120.17259ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:42:52.740762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.252795ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-07T21:42:52.740896Z","caller":"traceutil/trace.go:171","msg":"trace[777676187] linearizableReadLoop","detail":"{readStateIndex:1998; appliedIndex:1997; }","duration":"202.088316ms","start":"2026-03-07T21:42:52.538785Z","end":"2026-03-07T21:42:52.740873Z","steps":["trace[777676187] 'read index received' (duration: 19.679438ms)","trace[777676187] 'applied index is now lower than readState.Index' (duration: 182.407108ms)"],"step_count":2} {"level":"warn","ts":"2026-03-07T21:42:52.74117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.378894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-03-07T21:42:52.741261Z","caller":"traceutil/trace.go:171","msg":"trace[1198890734] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1923; }","duration":"202.526999ms","start":"2026-03-07T21:42:52.538713Z","end":"2026-03-07T21:42:52.74124Z","steps":["trace[1198890734] 'agreement among raft nodes before linearized reading' (duration: 202.304803ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:42:52.741149Z","caller":"traceutil/trace.go:171","msg":"trace[666454150] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"202.557779ms","start":"2026-03-07T21:42:52.538447Z","end":"2026-03-07T21:42:52.741005Z","steps":["trace[666454150] 'process raft request' (duration: 19.979397ms)","trace[666454150] 'compare' (duration: 182.129071ms)"],"step_count":2} {"level":"info","ts":"2026-03-07T21:42:52.836741Z","caller":"traceutil/trace.go:171","msg":"trace[662317861] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"101.364086ms","start":"2026-03-07T21:42:52.735347Z","end":"2026-03-07T21:42:52.836712Z","steps":["trace[662317861] 'process raft request' (duration: 101.146621ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:42:52.836882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.628835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-03-07T21:42:52.83697Z","caller":"traceutil/trace.go:171","msg":"trace[847078868] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1924; }","duration":"263.768219ms","start":"2026-03-07T21:42:52.573171Z","end":"2026-03-07T21:42:52.836939Z","steps":["trace[847078868] 'agreement among raft nodes before linearized reading' (duration: 263.546753ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:43:34.867041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.43059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-07T21:43:34.867175Z","caller":"traceutil/trace.go:171","msg":"trace[1316321613] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2304; }","duration":"169.633435ms","start":"2026-03-07T21:43:34.697522Z","end":"2026-03-07T21:43:34.867155Z","steps":["trace[1316321613] 'range keys from in-memory index tree' (duration: 169.340598ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:43:34.86715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.122491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-07T21:43:34.867255Z","caller":"traceutil/trace.go:171","msg":"trace[426818182] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:2304; }","duration":"188.261575ms","start":"2026-03-07T21:43:34.678965Z","end":"2026-03-07T21:43:34.867227Z","steps":["trace[426818182] 'count revisions from in-memory index tree' (duration: 188.04926ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:44:08.584236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.652801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-03-07T21:44:08.584412Z","caller":"traceutil/trace.go:171","msg":"trace[476148985] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2490; }","duration":"110.873937ms","start":"2026-03-07T21:44:08.473519Z","end":"2026-03-07T21:44:08.584392Z","steps":["trace[476148985] 'range keys from in-memory index tree' (duration: 110.478156ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:48:06.265723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.802974ms","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-03-07T21:48:06.265835Z","caller":"traceutil/trace.go:171","msg":"trace[1977024559] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4581; }","duration":"143.967908ms","start":"2026-03-07T21:48:06.121844Z","end":"2026-03-07T21:48:06.265812Z","steps":["trace[1977024559] 'range keys from in-memory index tree' (duration: 143.708681ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:48:06.266053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.758117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777458"} {"level":"info","ts":"2026-03-07T21:48:06.266166Z","caller":"traceutil/trace.go:171","msg":"trace[415363464] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:4581; }","duration":"142.926031ms","start":"2026-03-07T21:48:06.123214Z","end":"2026-03-07T21:48:06.26614Z","steps":["trace[415363464] 'range keys from in-memory index tree' (duration: 142.268713ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:48:23.35897Z","caller":"traceutil/trace.go:171","msg":"trace[1876983457] linearizableReadLoop","detail":"{readStateIndex:5080; appliedIndex:5079; }","duration":"167.751461ms","start":"2026-03-07T21:48:23.19119Z","end":"2026-03-07T21:48:23.358941Z","steps":["trace[1876983457] 'read index received' (duration: 167.483924ms)","trace[1876983457] 'applied index is now lower than readState.Index' (duration: 266.457µs)"],"step_count":2} {"level":"info","ts":"2026-03-07T21:48:23.359094Z","caller":"traceutil/trace.go:171","msg":"trace[251715279] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"230.02717ms","start":"2026-03-07T21:48:23.129037Z","end":"2026-03-07T21:48:23.359064Z","steps":["trace[251715279] 'process raft request' (duration: 229.757713ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:48:23.359262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.034708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-07T21:48:23.359343Z","caller":"traceutil/trace.go:171","msg":"trace[1431874933] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:4894; }","duration":"168.13714ms","start":"2026-03-07T21:48:23.191186Z","end":"2026-03-07T21:48:23.359323Z","steps":["trace[1431874933] 'agreement among raft nodes before linearized reading' (duration: 167.945795ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:48:23.359444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.302157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cff5e1ce-6b47-4566-86c9-b40eabca4ce1\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-03-07T21:48:23.359649Z","caller":"traceutil/trace.go:171","msg":"trace[969678208] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cff5e1ce-6b47-4566-86c9-b40eabca4ce1; range_end:; response_count:1; response_revision:4894; }","duration":"149.513683ms","start":"2026-03-07T21:48:23.210092Z","end":"2026-03-07T21:48:23.359605Z","steps":["trace[969678208] 'agreement among raft nodes before linearized reading' (duration: 149.090072ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:48:23.502725Z","caller":"traceutil/trace.go:171","msg":"trace[1413198484] transaction","detail":"{read_only:false; response_revision:4895; number_of_response:1; }","duration":"135.617829ms","start":"2026-03-07T21:48:23.367078Z","end":"2026-03-07T21:48:23.502696Z","steps":["trace[1413198484] 'process raft request' (duration: 135.419164ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:49:13.7479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.578081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-03-07T21:49:13.748063Z","caller":"traceutil/trace.go:171","msg":"trace[856343345] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5403; }","duration":"190.972651ms","start":"2026-03-07T21:49:13.557063Z","end":"2026-03-07T21:49:13.748036Z","steps":["trace[856343345] 'range keys from in-memory index tree' (duration: 190.344005ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:49:55.779385Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2728} {"level":"info","ts":"2026-03-07T21:49:55.840583Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2728,"took":"59.861733ms","hash":2202074729,"current-db-size-bytes":41398272,"current-db-size":"41 MB","current-db-size-in-use-bytes":30871552,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-03-07T21:49:55.840686Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2202074729,"revision":2728,"compact-revision":-1} {"level":"info","ts":"2026-03-07T21:54:27.312653Z","caller":"traceutil/trace.go:171","msg":"trace[1344058753] linearizableReadLoop","detail":"{readStateIndex:7843; appliedIndex:7842; }","duration":"178.752555ms","start":"2026-03-07T21:54:27.13387Z","end":"2026-03-07T21:54:27.312623Z","steps":["trace[1344058753] 'read index received' (duration: 178.595111ms)","trace[1344058753] 'applied index is now lower than readState.Index' (duration: 156.284µs)"],"step_count":2} {"level":"info","ts":"2026-03-07T21:54:27.312718Z","caller":"traceutil/trace.go:171","msg":"trace[859922570] transaction","detail":"{read_only:false; response_revision:7568; number_of_response:1; }","duration":"276.886295ms","start":"2026-03-07T21:54:27.035818Z","end":"2026-03-07T21:54:27.312704Z","steps":["trace[859922570] 'process raft request' (duration: 276.652878ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:54:27.31279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.899509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-07T21:54:27.312919Z","caller":"traceutil/trace.go:171","msg":"trace[1291094419] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:7568; }","duration":"179.069484ms","start":"2026-03-07T21:54:27.133834Z","end":"2026-03-07T21:54:27.312903Z","steps":["trace[1291094419] 'agreement among raft nodes before linearized reading' (duration: 178.892269ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:54:27.488594Z","caller":"traceutil/trace.go:171","msg":"trace[773443972] transaction","detail":"{read_only:false; response_revision:7570; number_of_response:1; }","duration":"239.587992ms","start":"2026-03-07T21:54:27.248979Z","end":"2026-03-07T21:54:27.488567Z","steps":["trace[773443972] 'process raft request' (duration: 239.493759ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:54:27.488655Z","caller":"traceutil/trace.go:171","msg":"trace[331939580] transaction","detail":"{read_only:false; response_revision:7569; number_of_response:1; }","duration":"321.572197ms","start":"2026-03-07T21:54:27.167055Z","end":"2026-03-07T21:54:27.488627Z","steps":["trace[331939580] 'process raft request' (duration: 310.668854ms)","trace[331939580] 'compare' (duration: 10.626236ms)"],"step_count":2} {"level":"warn","ts":"2026-03-07T21:54:27.488811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T21:54:27.167039Z","time spent":"321.660329ms","remote":"127.0.0.1:45236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-07T21:54:27.488806Z","caller":"traceutil/trace.go:171","msg":"trace[460479438] transaction","detail":"{read_only:false; response_revision:7571; number_of_response:1; }","duration":"198.168858ms","start":"2026-03-07T21:54:27.290606Z","end":"2026-03-07T21:54:27.488775Z","steps":["trace[460479438] 'process raft request' (duration: 197.912221ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:54:38.77041Z","caller":"traceutil/trace.go:171","msg":"trace[203744] linearizableReadLoop","detail":"{readStateIndex:7902; appliedIndex:7901; }","duration":"176.192611ms","start":"2026-03-07T21:54:38.594186Z","end":"2026-03-07T21:54:38.770379Z","steps":["trace[203744] 'read index received' (duration: 175.845502ms)","trace[203744] 'applied index is now lower than readState.Index' (duration: 345.699µs)"],"step_count":2} {"level":"info","ts":"2026-03-07T21:54:38.770429Z","caller":"traceutil/trace.go:171","msg":"trace[1335264762] transaction","detail":"{read_only:false; response_revision:7624; number_of_response:1; }","duration":"183.621905ms","start":"2026-03-07T21:54:38.586774Z","end":"2026-03-07T21:54:38.770396Z","steps":["trace[1335264762] 'process raft request' (duration: 183.398189ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:54:38.770741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.532801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-03-07T21:54:38.770804Z","caller":"traceutil/trace.go:171","msg":"trace[754415958] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:7624; }","duration":"176.627814ms","start":"2026-03-07T21:54:38.594161Z","end":"2026-03-07T21:54:38.770789Z","steps":["trace[754415958] 'agreement among raft nodes before linearized reading' (duration: 176.325505ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:54:55.7925Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5694} {"level":"info","ts":"2026-03-07T21:54:55.889881Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5694,"took":"95.489288ms","hash":2058517137,"current-db-size-bytes":42524672,"current-db-size":"42 MB","current-db-size-in-use-bytes":23064576,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-03-07T21:54:55.889953Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2058517137,"revision":5694,"compact-revision":2728} {"level":"info","ts":"2026-03-07T21:55:10.458716Z","caller":"traceutil/trace.go:171","msg":"trace[434955765] transaction","detail":"{read_only:false; response_revision:7833; number_of_response:1; }","duration":"104.284018ms","start":"2026-03-07T21:55:10.354408Z","end":"2026-03-07T21:55:10.458692Z","steps":["trace[434955765] 'process raft request' (duration: 83.10142ms)","trace[434955765] 'compare' (duration: 21.065045ms)"],"step_count":2} {"level":"info","ts":"2026-03-07T21:55:19.186984Z","caller":"traceutil/trace.go:171","msg":"trace[1714023782] transaction","detail":"{read_only:false; response_revision:7914; number_of_response:1; }","duration":"101.571965ms","start":"2026-03-07T21:55:19.085373Z","end":"2026-03-07T21:55:19.186945Z","steps":["trace[1714023782] 'process raft request' (duration: 101.339629ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:55:19.341394Z","caller":"traceutil/trace.go:171","msg":"trace[1882494299] transaction","detail":"{read_only:false; response_revision:7916; number_of_response:1; }","duration":"115.213557ms","start":"2026-03-07T21:55:19.226153Z","end":"2026-03-07T21:55:19.341366Z","steps":["trace[1882494299] 'process raft request' (duration: 63.842844ms)","trace[1882494299] 'compare' (duration: 51.198208ms)"],"step_count":2} {"level":"info","ts":"2026-03-07T21:55:19.346739Z","caller":"traceutil/trace.go:171","msg":"trace[759611642] transaction","detail":"{read_only:false; number_of_response:1; response_revision:7917; }","duration":"119.375011ms","start":"2026-03-07T21:55:19.227339Z","end":"2026-03-07T21:55:19.346714Z","steps":["trace[759611642] 'process raft request' (duration: 119.205627ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:55:19.34693Z","caller":"traceutil/trace.go:171","msg":"trace[1009627056] transaction","detail":"{read_only:false; response_revision:7918; number_of_response:1; }","duration":"108.566975ms","start":"2026-03-07T21:55:19.238346Z","end":"2026-03-07T21:55:19.346913Z","steps":["trace[1009627056] 'process raft request' (duration: 108.310409ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:55:19.92331Z","caller":"traceutil/trace.go:171","msg":"trace[855185082] transaction","detail":"{read_only:false; response_revision:7920; number_of_response:1; }","duration":"373.585634ms","start":"2026-03-07T21:55:19.549696Z","end":"2026-03-07T21:55:19.923281Z","steps":["trace[855185082] 'process raft request' (duration: 278.642431ms)","trace[855185082] 'compare' (duration: 94.675866ms)"],"step_count":2} {"level":"warn","ts":"2026-03-07T21:55:19.92348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T21:55:19.549674Z","time spent":"373.721368ms","remote":"127.0.0.1:45138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4631,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-07T21:55:20.169173Z","caller":"traceutil/trace.go:171","msg":"trace[262490349] transaction","detail":"{read_only:false; response_revision:7921; number_of_response:1; }","duration":"489.568691ms","start":"2026-03-07T21:55:19.679572Z","end":"2026-03-07T21:55:20.169141Z","steps":["trace[262490349] 'process raft request' (duration: 471.238051ms)","trace[262490349] 'compare' (duration: 18.158335ms)"],"step_count":2} {"level":"warn","ts":"2026-03-07T21:55:20.169341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T21:55:19.679548Z","time spent":"489.717595ms","remote":"127.0.0.1:45236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-07T21:55:20.16919Z","caller":"traceutil/trace.go:171","msg":"trace[2049851294] transaction","detail":"{read_only:false; response_revision:7922; number_of_response:1; }","duration":"429.242904ms","start":"2026-03-07T21:55:19.739926Z","end":"2026-03-07T21:55:20.169169Z","steps":["trace[2049851294] 'process raft request' (duration: 429.168432ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:55:20.169566Z","caller":"traceutil/trace.go:171","msg":"trace[804332227] linearizableReadLoop","detail":"{readStateIndex:8214; appliedIndex:8212; }","duration":"471.810958ms","start":"2026-03-07T21:55:19.697724Z","end":"2026-03-07T21:55:20.169535Z","steps":["trace[804332227] 'read index received' (duration: 130.621588ms)","trace[804332227] 'applied index is now lower than readState.Index' (duration: 341.18739ms)"],"step_count":2} {"level":"info","ts":"2026-03-07T21:55:20.169671Z","caller":"traceutil/trace.go:171","msg":"trace[1588542048] transaction","detail":"{read_only:false; response_revision:7923; number_of_response:1; }","duration":"429.218245ms","start":"2026-03-07T21:55:19.74043Z","end":"2026-03-07T21:55:20.169649Z","steps":["trace[1588542048] 'process raft request' (duration: 428.70727ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:55:20.169567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T21:55:19.739898Z","time spent":"429.534322ms","remote":"127.0.0.1:45236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-07T21:55:20.169738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.009693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-07T21:55:20.169791Z","caller":"traceutil/trace.go:171","msg":"trace[273718416] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7923; }","duration":"472.092125ms","start":"2026-03-07T21:55:19.697683Z","end":"2026-03-07T21:55:20.169775Z","steps":["trace[273718416] 'agreement among raft nodes before linearized reading' (duration: 471.990422ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:55:20.169792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T21:55:19.740409Z","time spent":"429.335207ms","remote":"127.0.0.1:45236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-07T21:55:20.169844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T21:55:19.697667Z","time spent":"472.166287ms","remote":"127.0.0.1:44938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-07T21:55:20.197886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.296502ms","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-03-07T21:55:20.197925Z","caller":"traceutil/trace.go:171","msg":"trace[485040543] transaction","detail":"{read_only:false; response_revision:7924; number_of_response:1; }","duration":"113.46946ms","start":"2026-03-07T21:55:20.084423Z","end":"2026-03-07T21:55:20.197892Z","steps":["trace[485040543] 'process raft request' (duration: 113.161712ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:55:20.197968Z","caller":"traceutil/trace.go:171","msg":"trace[100973570] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:7924; }","duration":"289.392265ms","start":"2026-03-07T21:55:19.908541Z","end":"2026-03-07T21:55:20.197933Z","steps":["trace[100973570] 'agreement among raft nodes before linearized reading' (duration: 289.279022ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:55:20.198038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.884317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5c6nx\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-03-07T21:55:20.198091Z","caller":"traceutil/trace.go:171","msg":"trace[443087998] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5c6nx; range_end:; response_count:1; response_revision:7924; }","duration":"275.963398ms","start":"2026-03-07T21:55:19.922115Z","end":"2026-03-07T21:55:20.198078Z","steps":["trace[443087998] 'agreement among raft nodes before linearized reading' (duration: 275.798584ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:55:20.198115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.097753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-07T21:55:20.198232Z","caller":"traceutil/trace.go:171","msg":"trace[955348440] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:7924; }","duration":"220.293378ms","start":"2026-03-07T21:55:19.977921Z","end":"2026-03-07T21:55:20.198214Z","steps":["trace[955348440] 'agreement among raft nodes before linearized reading' (duration: 219.929468ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:55:20.198347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.779723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-03-07T21:55:20.198425Z","caller":"traceutil/trace.go:171","msg":"trace[71992474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7924; }","duration":"320.903905ms","start":"2026-03-07T21:55:19.877508Z","end":"2026-03-07T21:55:20.198412Z","steps":["trace[71992474] 'agreement among raft nodes before linearized reading' (duration: 320.541895ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:55:20.198472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T21:55:19.877481Z","time spent":"320.980567ms","remote":"127.0.0.1:45236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-07T21:55:21.032757Z","caller":"traceutil/trace.go:171","msg":"trace[598463112] linearizableReadLoop","detail":"{readStateIndex:8222; appliedIndex:8221; }","duration":"190.050611ms","start":"2026-03-07T21:55:20.842672Z","end":"2026-03-07T21:55:21.032722Z","steps":["trace[598463112] 'read index received' (duration: 189.861746ms)","trace[598463112] 'applied index is now lower than readState.Index' (duration: 187.785µs)"],"step_count":2} {"level":"info","ts":"2026-03-07T21:55:21.032891Z","caller":"traceutil/trace.go:171","msg":"trace[425843140] transaction","detail":"{read_only:false; response_revision:7929; number_of_response:1; }","duration":"195.029258ms","start":"2026-03-07T21:55:20.83785Z","end":"2026-03-07T21:55:21.032879Z","steps":["trace[425843140] 'process raft request' (duration: 194.582695ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:55:21.0331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.412991ms","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-03-07T21:55:21.033158Z","caller":"traceutil/trace.go:171","msg":"trace[1362387373] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7929; }","duration":"190.505234ms","start":"2026-03-07T21:55:20.842639Z","end":"2026-03-07T21:55:21.033144Z","steps":["trace[1362387373] 'agreement among raft nodes before linearized reading' (duration: 190.35429ms)"],"step_count":1} {"level":"warn","ts":"2026-03-07T21:55:21.572732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.376399ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-07T21:55:21.572941Z","caller":"traceutil/trace.go:171","msg":"trace[259857284] transaction","detail":"{read_only:false; response_revision:7932; number_of_response:1; }","duration":"345.288601ms","start":"2026-03-07T21:55:21.227633Z","end":"2026-03-07T21:55:21.572921Z","steps":["trace[259857284] 'process raft request' (duration: 46.637364ms)","trace[259857284] 'compare' (duration: 298.247306ms)"],"step_count":2} {"level":"warn","ts":"2026-03-07T21:55:21.573017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-07T21:55:21.227578Z","time spent":"345.403064ms","remote":"127.0.0.1:45236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-07T21:56:38.22953Z","caller":"traceutil/trace.go:171","msg":"trace[1582076469] transaction","detail":"{read_only:false; response_revision:8638; number_of_response:1; }","duration":"240.749508ms","start":"2026-03-07T21:56:37.988743Z","end":"2026-03-07T21:56:38.229492Z","steps":["trace[1582076469] 'process raft request' (duration: 240.379998ms)"],"step_count":1} {"level":"info","ts":"2026-03-07T21:58:57.084603Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b11e7fc5714be64b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-07T21:58:57.090749Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-07T21:58:57.09087Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-07T21:59:55.799116Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7713} {"level":"info","ts":"2026-03-07T21:59:55.864568Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7713,"took":"63.268317ms","hash":4192982012,"current-db-size-bytes":42524672,"current-db-size":"42 MB","current-db-size-in-use-bytes":26267648,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-03-07T21:59:55.864618Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4192982012,"revision":7713,"compact-revision":5694} {"level":"info","ts":"2026-03-07T22:04:55.805711Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9960} {"level":"info","ts":"2026-03-07T22:04:55.888021Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9960,"took":"80.704592ms","hash":2858467574,"current-db-size-bytes":42524672,"current-db-size":"42 MB","current-db-size-in-use-bytes":16826368,"current-db-size-in-use":"17 MB"} {"level":"info","ts":"2026-03-07T22:04:55.888105Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2858467574,"revision":9960,"compact-revision":7713}