{"level":"warn","ts":"2026-05-29T13:57:38.885047Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-29T13:57:38.885174Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.157:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.157:2380","--initial-cluster=instance=https://199.204.45.157:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.157:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.157: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-05-29T13:57:38.885522Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-29T13:57:38.885543Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-05-29T13:57:38.885598Z","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-05-29T13:57:38.886789Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"]} {"level":"info","ts":"2026-05-29T13:57:38.886995Z","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://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.157: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-05-29T13:57:38.891109Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.691506ms"} {"level":"info","ts":"2026-05-29T13:57:38.896816Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f170c75a1d97cc","cluster-id":"44a3176ec85feb9"} {"level":"info","ts":"2026-05-29T13:57:38.896928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=()"} {"level":"info","ts":"2026-05-29T13:57:38.897028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 0"} {"level":"info","ts":"2026-05-29T13:57:38.897068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f170c75a1d97cc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-29T13:57:38.897124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 1"} {"level":"info","ts":"2026-05-29T13:57:38.897227Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"warn","ts":"2026-05-29T13:57:38.905023Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-29T13:57:38.907014Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-29T13:57:38.908285Z","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-05-29T13:57:38.911641Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f170c75a1d97cc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-29T13:57:38.91271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"info","ts":"2026-05-29T13:57:38.914115Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f170c75a1d97cc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-29T13:57:38.914334Z","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-05-29T13:57:38.914375Z","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-05-29T13:57:38.916068Z","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-05-29T13:57:38.91829Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","added-peer-id":"5f170c75a1d97cc","added-peer-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-05-29T13:57:38.919158Z","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-05-29T13:57:38.919295Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-05-29T13:57:38.919319Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-05-29T13:57:38.919583Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f170c75a1d97cc","initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-29T13:57:38.919611Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-29T13:57:39.098414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc is starting a new election at term 1"} {"level":"info","ts":"2026-05-29T13:57:39.098467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became pre-candidate at term 1"} {"level":"info","ts":"2026-05-29T13:57:39.098493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgPreVoteResp from 5f170c75a1d97cc at term 1"} {"level":"info","ts":"2026-05-29T13:57:39.098507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became candidate at term 2"} {"level":"info","ts":"2026-05-29T13:57:39.098516Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgVoteResp from 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-05-29T13:57:39.098532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became leader at term 2"} {"level":"info","ts":"2026-05-29T13:57:39.098546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f170c75a1d97cc elected leader 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-05-29T13:57:39.099577Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f170c75a1d97cc","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.157:2379]}","request-path":"/0/members/5f170c75a1d97cc/attributes","cluster-id":"44a3176ec85feb9","publish-timeout":"7s"} {"level":"info","ts":"2026-05-29T13:57:39.099643Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T13:57:39.099702Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T13:57:39.101993Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.157:2379"} {"level":"info","ts":"2026-05-29T13:57:39.099591Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T13:57:39.102276Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-29T13:57:39.102359Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-29T13:57:39.103154Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T13:57:39.103394Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T13:57:39.10348Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T13:57:39.104682Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-29T13:57:45.283619Z","caller":"traceutil/trace.go:171","msg":"trace[624816167] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"160.300817ms","start":"2026-05-29T13:57:45.123284Z","end":"2026-05-29T13:57:45.283585Z","steps":["trace[624816167] 'process raft request' (duration: 109.104634ms)","trace[624816167] 'compare' (duration: 50.918608ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:57:45.283584Z","caller":"traceutil/trace.go:171","msg":"trace[379203284] linearizableReadLoop","detail":"{readStateIndex:317; appliedIndex:316; }","duration":"154.653458ms","start":"2026-05-29T13:57:45.128896Z","end":"2026-05-29T13:57:45.283549Z","steps":["trace[379203284] 'read index received' (duration: 103.544276ms)","trace[379203284] 'applied index is now lower than readState.Index' (duration: 51.106592ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T13:57:45.283879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.956283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-29T13:57:45.283978Z","caller":"traceutil/trace.go:171","msg":"trace[1240363849] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:307; }","duration":"155.108236ms","start":"2026-05-29T13:57:45.12885Z","end":"2026-05-29T13:57:45.283958Z","steps":["trace[1240363849] 'agreement among raft nodes before linearized reading' (duration: 154.839011ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:45.685061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.411249ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-05-29T13:57:45.685472Z","caller":"traceutil/trace.go:171","msg":"trace[1452425373] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"397.91779ms","start":"2026-05-29T13:57:45.287543Z","end":"2026-05-29T13:57:45.685461Z","steps":["trace[1452425373] 'process raft request' (duration: 397.693485ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:45.685561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:57:45.287529Z","time spent":"397.976991ms","remote":"127.0.0.1:50256","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T13:57:45.685395Z","caller":"traceutil/trace.go:171","msg":"trace[1748149594] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"396.490882ms","start":"2026-05-29T13:57:45.288885Z","end":"2026-05-29T13:57:45.685375Z","steps":["trace[1748149594] 'process raft request' (duration: 396.435821ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:57:45.685591Z","caller":"traceutil/trace.go:171","msg":"trace[1961007207] transaction","detail":"{read_only:false; number_of_response:0; response_revision:307; }","duration":"481.592151ms","start":"2026-05-29T13:57:45.203968Z","end":"2026-05-29T13:57:45.68556Z","steps":["trace[1961007207] 'process raft request' (duration: 481.202964ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:45.68568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.968148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3468"} {"level":"warn","ts":"2026-05-29T13:57:45.6857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:57:45.288861Z","time spent":"396.798177ms","remote":"127.0.0.1:50168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":705,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T13:57:45.685706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:57:45.203959Z","time spent":"481.708713ms","remote":"127.0.0.1:50244","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T13:57:45.685753Z","caller":"traceutil/trace.go:171","msg":"trace[421137095] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:309; }","duration":"483.10372ms","start":"2026-05-29T13:57:45.202632Z","end":"2026-05-29T13:57:45.685736Z","steps":["trace[421137095] 'agreement among raft nodes before linearized reading' (duration: 482.866325ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:57:45.685445Z","caller":"traceutil/trace.go:171","msg":"trace[1703713974] linearizableReadLoop","detail":"{readStateIndex:319; appliedIndex:317; }","duration":"401.54223ms","start":"2026-05-29T13:57:45.283874Z","end":"2026-05-29T13:57:45.685417Z","steps":["trace[1703713974] 'read index received' (duration: 192.778485ms)","trace[1703713974] 'applied index is now lower than readState.Index' (duration: 208.758985ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T13:57:45.685803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:57:45.202605Z","time spent":"483.185402ms","remote":"127.0.0.1:50244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":3490,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "} {"level":"warn","ts":"2026-05-29T13:57:45.685928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.655384ms","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-05-29T13:57:45.685957Z","caller":"traceutil/trace.go:171","msg":"trace[1365664771] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:309; }","duration":"398.717625ms","start":"2026-05-29T13:57:45.28723Z","end":"2026-05-29T13:57:45.685948Z","steps":["trace[1365664771] 'agreement among raft nodes before linearized reading' (duration: 398.643413ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:45.685977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:57:45.287214Z","time spent":"398.759546ms","remote":"127.0.0.1:50324","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-05-29T13:57:45.685383Z","caller":"traceutil/trace.go:171","msg":"trace[407803508] transaction","detail":"{read_only:false; number_of_response:0; response_revision:307; }","duration":"482.02695ms","start":"2026-05-29T13:57:45.203297Z","end":"2026-05-29T13:57:45.685324Z","steps":["trace[407803508] 'process raft request' (duration: 273.376928ms)","trace[407803508] 'compare' (duration: 207.351667ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T13:57:45.686176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:57:45.203281Z","time spent":"482.858805ms","remote":"127.0.0.1:50244","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T13:57:48.610261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.547986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-29T13:57:48.610361Z","caller":"traceutil/trace.go:171","msg":"trace[1015253690] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:345; }","duration":"230.72118ms","start":"2026-05-29T13:57:48.379619Z","end":"2026-05-29T13:57:48.610341Z","steps":["trace[1015253690] 'range keys from in-memory index tree' (duration: 230.436934ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:48.610564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.2452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-29T13:57:48.610726Z","caller":"traceutil/trace.go:171","msg":"trace[1924254925] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:345; }","duration":"131.461194ms","start":"2026-05-29T13:57:48.479237Z","end":"2026-05-29T13:57:48.610699Z","steps":["trace[1924254925] 'range keys from in-memory index tree' (duration: 131.078846ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:57:48.610688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.816856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-05-29T13:57:48.610811Z","caller":"traceutil/trace.go:171","msg":"trace[1570478915] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:345; }","duration":"182.026219ms","start":"2026-05-29T13:57:48.428768Z","end":"2026-05-29T13:57:48.610794Z","steps":["trace[1570478915] 'range keys from in-memory index tree' (duration: 181.698423ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:58:17.006116Z","caller":"traceutil/trace.go:171","msg":"trace[1933319915] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"227.262778ms","start":"2026-05-29T13:58:16.778832Z","end":"2026-05-29T13:58:17.006095Z","steps":["trace[1933319915] 'read index received' (duration: 226.80883ms)","trace[1933319915] 'applied index is now lower than readState.Index' (duration: 453.018µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:58:17.006177Z","caller":"traceutil/trace.go:171","msg":"trace[256136493] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"245.504929ms","start":"2026-05-29T13:58:16.760639Z","end":"2026-05-29T13:58:17.006144Z","steps":["trace[256136493] 'process raft request' (duration: 245.206954ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:58:17.006306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.456961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:65436"} {"level":"info","ts":"2026-05-29T13:58:17.006342Z","caller":"traceutil/trace.go:171","msg":"trace[1578372022] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:599; }","duration":"227.549362ms","start":"2026-05-29T13:58:16.778782Z","end":"2026-05-29T13:58:17.006331Z","steps":["trace[1578372022] 'agreement among raft nodes before linearized reading' (duration: 227.40365ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:58:21.30742Z","caller":"traceutil/trace.go:171","msg":"trace[1389989363] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"174.660336ms","start":"2026-05-29T13:58:21.132741Z","end":"2026-05-29T13:58:21.307402Z","steps":["trace[1389989363] 'process raft request' (duration: 173.794333ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:58:21.818599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.267731ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-29T13:58:21.818897Z","caller":"traceutil/trace.go:171","msg":"trace[1274176257] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"452.053151ms","start":"2026-05-29T13:58:21.366804Z","end":"2026-05-29T13:58:21.818857Z","steps":["trace[1274176257] 'process raft request' (duration: 275.425005ms)","trace[1274176257] 'compare' (duration: 176.043787ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:58:21.818934Z","caller":"traceutil/trace.go:171","msg":"trace[372474068] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"204.939377ms","start":"2026-05-29T13:58:21.613974Z","end":"2026-05-29T13:58:21.818913Z","steps":["trace[372474068] 'process raft request' (duration: 204.847946ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:58:21.818998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:58:21.366777Z","time spent":"452.182373ms","remote":"127.0.0.1:50412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T13:58:21.819149Z","caller":"traceutil/trace.go:171","msg":"trace[974411385] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"449.508054ms","start":"2026-05-29T13:58:21.369612Z","end":"2026-05-29T13:58:21.81912Z","steps":["trace[974411385] 'process raft request' (duration: 449.113038ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:58:21.819557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T13:58:21.369605Z","time spent":"449.633656ms","remote":"127.0.0.1:50324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-29T13:58:35.998758Z","caller":"traceutil/trace.go:171","msg":"trace[1247975332] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"104.557052ms","start":"2026-05-29T13:58:35.894178Z","end":"2026-05-29T13:58:35.998735Z","steps":["trace[1247975332] 'process raft request' (duration: 104.074875ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:59:07.702767Z","caller":"traceutil/trace.go:171","msg":"trace[346929396] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"152.602865ms","start":"2026-05-29T13:59:07.550146Z","end":"2026-05-29T13:59:07.702749Z","steps":["trace[346929396] 'process raft request' (duration: 152.509044ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:59:53.746145Z","caller":"traceutil/trace.go:171","msg":"trace[1505215478] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1928; }","duration":"219.747893ms","start":"2026-05-29T13:59:53.526372Z","end":"2026-05-29T13:59:53.74612Z","steps":["trace[1505215478] 'read index received' (duration: 219.542781ms)","trace[1505215478] 'applied index is now lower than readState.Index' (duration: 204.252µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T13:59:53.746238Z","caller":"traceutil/trace.go:171","msg":"trace[1608321360] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"261.273212ms","start":"2026-05-29T13:59:53.484923Z","end":"2026-05-29T13:59:53.746196Z","steps":["trace[1608321360] 'process raft request' (duration: 261.04694ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T13:59:53.747154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.769093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-becda4cf-b403-47a5-b4f4-a5833500428f\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-29T13:59:53.747227Z","caller":"traceutil/trace.go:171","msg":"trace[902382638] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-becda4cf-b403-47a5-b4f4-a5833500428f; range_end:; response_count:1; response_revision:1858; }","duration":"220.894524ms","start":"2026-05-29T13:59:53.526315Z","end":"2026-05-29T13:59:53.74721Z","steps":["trace[902382638] 'agreement among raft nodes before linearized reading' (duration: 219.912334ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T13:59:54.116043Z","caller":"traceutil/trace.go:171","msg":"trace[1038296303] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"252.193226ms","start":"2026-05-29T13:59:53.863785Z","end":"2026-05-29T13:59:54.115979Z","steps":["trace[1038296303] 'process raft request' (duration: 197.932986ms)","trace[1038296303] 'compare' (duration: 53.830526ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T14:00:10.388421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.513467ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T14:00:10.388566Z","caller":"traceutil/trace.go:171","msg":"trace[643573447] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1983; }","duration":"130.670589ms","start":"2026-05-29T14:00:10.257875Z","end":"2026-05-29T14:00:10.388545Z","steps":["trace[643573447] 'range keys from in-memory index tree' (duration: 130.497517ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T14:00:10.426038Z","caller":"traceutil/trace.go:171","msg":"trace[1023788395] linearizableReadLoop","detail":"{readStateIndex:2059; appliedIndex:2058; }","duration":"345.657612ms","start":"2026-05-29T14:00:10.080354Z","end":"2026-05-29T14:00:10.426012Z","steps":["trace[1023788395] 'read index received' (duration: 345.49259ms)","trace[1023788395] 'applied index is now lower than readState.Index' (duration: 163.912µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T14:00:10.426188Z","caller":"traceutil/trace.go:171","msg":"trace[909016520] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"405.277789ms","start":"2026-05-29T14:00:10.020852Z","end":"2026-05-29T14:00:10.42613Z","steps":["trace[909016520] 'process raft request' (duration: 404.971476ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T14:00:10.426356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T14:00:10.020833Z","time spent":"405.433071ms","remote":"127.0.0.1:50520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5595,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T14:00:10.426211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.833363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T14:00:10.426506Z","caller":"traceutil/trace.go:171","msg":"trace[901819582] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1984; }","duration":"346.178228ms","start":"2026-05-29T14:00:10.080311Z","end":"2026-05-29T14:00:10.42649Z","steps":["trace[901819582] 'agreement among raft nodes before linearized reading' (duration: 345.835254ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T14:00:10.426571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T14:00:10.080285Z","time spent":"346.255859ms","remote":"127.0.0.1:50096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-29T14:00:10.428343Z","caller":"traceutil/trace.go:171","msg":"trace[1013512046] transaction","detail":"{read_only:false; response_revision:1985; number_of_response:1; }","duration":"257.909383ms","start":"2026-05-29T14:00:10.170401Z","end":"2026-05-29T14:00:10.428311Z","steps":["trace[1013512046] 'process raft request' (duration: 257.519589ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T14:00:10.428697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.886263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-29T14:00:10.428766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.336659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-29T14:00:10.428809Z","caller":"traceutil/trace.go:171","msg":"trace[410365833] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1986; }","duration":"278.047846ms","start":"2026-05-29T14:00:10.150746Z","end":"2026-05-29T14:00:10.428794Z","steps":["trace[410365833] 'agreement among raft nodes before linearized reading' (duration: 277.884544ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T14:00:10.428827Z","caller":"traceutil/trace.go:171","msg":"trace[1828083823] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1986; }","duration":"345.4094ms","start":"2026-05-29T14:00:10.083403Z","end":"2026-05-29T14:00:10.428812Z","steps":["trace[1828083823] 'agreement among raft nodes before linearized reading' (duration: 345.299569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T14:00:10.42886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T14:00:10.083355Z","time spent":"345.49931ms","remote":"127.0.0.1:50438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":29,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"info","ts":"2026-05-29T14:00:10.429093Z","caller":"traceutil/trace.go:171","msg":"trace[493556856] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"112.954261ms","start":"2026-05-29T14:00:10.316124Z","end":"2026-05-29T14:00:10.429078Z","steps":["trace[493556856] 'process raft request' (duration: 112.096023ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T14:00:10.429212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.866441ms","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-05-29T14:00:10.42926Z","caller":"traceutil/trace.go:171","msg":"trace[1972052861] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1986; }","duration":"200.962443ms","start":"2026-05-29T14:00:10.228281Z","end":"2026-05-29T14:00:10.429243Z","steps":["trace[1972052861] 'agreement among raft nodes before linearized reading' (duration: 200.821871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T14:00:27.757731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.605552ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-29T14:00:33.226829Z","caller":"traceutil/trace.go:171","msg":"trace[1554929321] linearizableReadLoop","detail":"{readStateIndex:2201; appliedIndex:2200; }","duration":"116.438049ms","start":"2026-05-29T14:00:33.110371Z","end":"2026-05-29T14:00:33.226809Z","steps":["trace[1554929321] 'read index received' (duration: 116.247967ms)","trace[1554929321] 'applied index is now lower than readState.Index' (duration: 189.012µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T14:00:33.227036Z","caller":"traceutil/trace.go:171","msg":"trace[1583601878] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"126.78205ms","start":"2026-05-29T14:00:33.100241Z","end":"2026-05-29T14:00:33.227023Z","steps":["trace[1583601878] 'process raft request' (duration: 126.401327ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T14:00:33.227363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.974434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-29T14:00:33.227428Z","caller":"traceutil/trace.go:171","msg":"trace[909945944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2121; }","duration":"117.086316ms","start":"2026-05-29T14:00:33.110328Z","end":"2026-05-29T14:00:33.227415Z","steps":["trace[909945944] 'agreement among raft nodes before linearized reading' (duration: 116.960495ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T14:00:34.377562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.452304ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T14:00:34.37769Z","caller":"traceutil/trace.go:171","msg":"trace[616661637] linearizableReadLoop","detail":"{readStateIndex:2206; appliedIndex:2205; }","duration":"298.978224ms","start":"2026-05-29T14:00:34.078694Z","end":"2026-05-29T14:00:34.377672Z","steps":["trace[616661637] 'read index received' (duration: 47.266988ms)","trace[616661637] 'applied index is now lower than readState.Index' (duration: 251.709916ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T14:00:34.377781Z","caller":"traceutil/trace.go:171","msg":"trace[1463729958] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"425.796544ms","start":"2026-05-29T14:00:33.951973Z","end":"2026-05-29T14:00:34.37777Z","steps":["trace[1463729958] 'process raft request' (duration: 174.039237ms)","trace[1463729958] 'compare' (duration: 251.128041ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T14:00:34.377872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T14:00:33.951953Z","time spent":"425.870655ms","remote":"127.0.0.1:50324","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T14:00:34.377969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.271688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T14:00:34.378291Z","caller":"traceutil/trace.go:171","msg":"trace[1186148143] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2126; }","duration":"299.577751ms","start":"2026-05-29T14:00:34.07869Z","end":"2026-05-29T14:00:34.378268Z","steps":["trace[1186148143] 'agreement among raft nodes before linearized reading' (duration: 299.248088ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T14:00:34.810752Z","caller":"traceutil/trace.go:171","msg":"trace[1845649128] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"165.669874ms","start":"2026-05-29T14:00:34.645053Z","end":"2026-05-29T14:00:34.810723Z","steps":["trace[1845649128] 'process raft request' (duration: 159.622366ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T14:01:57.027269Z","caller":"traceutil/trace.go:171","msg":"trace[469633447] transaction","detail":"{read_only:false; response_revision:2685; number_of_response:1; }","duration":"157.061753ms","start":"2026-05-29T14:01:56.870175Z","end":"2026-05-29T14:01:57.027237Z","steps":["trace[469633447] 'process raft request' (duration: 156.804807ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T14:05:29.126192Z","caller":"traceutil/trace.go:171","msg":"trace[1533488242] transaction","detail":"{read_only:false; response_revision:4362; number_of_response:1; }","duration":"108.269377ms","start":"2026-05-29T14:05:29.017897Z","end":"2026-05-29T14:05:29.126167Z","steps":["trace[1533488242] 'process raft request' (duration: 106.042087ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T14:05:29.144346Z","caller":"traceutil/trace.go:171","msg":"trace[2069893792] linearizableReadLoop","detail":"{readStateIndex:4529; appliedIndex:4527; }","duration":"119.210955ms","start":"2026-05-29T14:05:29.025094Z","end":"2026-05-29T14:05:29.144305Z","steps":["trace[2069893792] 'read index received' (duration: 99.01605ms)","trace[2069893792] 'applied index is now lower than readState.Index' (duration: 20.193485ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T14:05:29.144522Z","caller":"traceutil/trace.go:171","msg":"trace[1156269184] transaction","detail":"{read_only:false; response_revision:4363; number_of_response:1; }","duration":"119.393448ms","start":"2026-05-29T14:05:29.025056Z","end":"2026-05-29T14:05:29.14445Z","steps":["trace[1156269184] 'process raft request' (duration: 119.105384ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T14:05:29.144702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.53341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-05-29T14:05:29.144949Z","caller":"traceutil/trace.go:171","msg":"trace[929904178] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4363; }","duration":"119.868345ms","start":"2026-05-29T14:05:29.02506Z","end":"2026-05-29T14:05:29.144928Z","steps":["trace[929904178] 'agreement among raft nodes before linearized reading' (duration: 119.419239ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T14:05:39.6676Z","caller":"traceutil/trace.go:171","msg":"trace[1962971116] transaction","detail":"{read_only:false; response_revision:4620; number_of_response:1; }","duration":"218.946986ms","start":"2026-05-29T14:05:39.448624Z","end":"2026-05-29T14:05:39.667571Z","steps":["trace[1962971116] 'process raft request' (duration: 218.805494ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T14:05:52.003299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.799095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-29T14:05:52.003393Z","caller":"traceutil/trace.go:171","msg":"trace[1769163550] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4782; }","duration":"266.949228ms","start":"2026-05-29T14:05:51.736426Z","end":"2026-05-29T14:05:52.003375Z","steps":["trace[1769163550] 'range keys from in-memory index tree' (duration: 266.599332ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T14:05:52.016271Z","caller":"traceutil/trace.go:171","msg":"trace[515609686] transaction","detail":"{read_only:false; response_revision:4783; number_of_response:1; }","duration":"186.595223ms","start":"2026-05-29T14:05:51.829636Z","end":"2026-05-29T14:05:52.016231Z","steps":["trace[515609686] 'process raft request' (duration: 186.475572ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T14:07:39.436923Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2907} {"level":"info","ts":"2026-05-29T14:07:39.523071Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2907,"took":"84.696803ms","hash":1237242080,"current-db-size-bytes":54038528,"current-db-size":"54 MB","current-db-size-in-use-bytes":29528064,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-29T14:07:39.523147Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1237242080,"revision":2907,"compact-revision":-1} {"level":"info","ts":"2026-05-29T14:12:39.443181Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5631} {"level":"info","ts":"2026-05-29T14:12:39.585862Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5631,"took":"141.530264ms","hash":3861285765,"current-db-size-bytes":54038528,"current-db-size":"54 MB","current-db-size-in-use-bytes":18276352,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-29T14:12:39.585921Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3861285765,"revision":5631,"compact-revision":2907}