{"level":"warn","ts":"2026-03-20T05:33:33.857043Z","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-20T05:33:33.857125Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.169: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.169:2380","--initial-cluster=instance=https://199.204.45.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.169: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-20T05:33:33.857181Z","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-20T05:33:33.857189Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-03-20T05:33:33.857207Z","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-20T05:33:33.857792Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"]} {"level":"info","ts":"2026-03-20T05:33:33.857859Z","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://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.169: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-20T05:33:33.860711Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.646871ms"} {"level":"info","ts":"2026-03-20T05:33:33.869887Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-03-20T05:33:33.869945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-03-20T05:33:33.869965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-03-20T05:33:33.869972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1c917701ce165bac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-20T05:33:33.869984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-03-20T05:33:33.87001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-03-20T05:33:33.879332Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-20T05:33:33.881398Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-20T05:33:33.882764Z","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-20T05:33:33.88562Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1c917701ce165bac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-20T05:33:33.887871Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1c917701ce165bac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-20T05:33:33.888008Z","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-20T05:33:33.888138Z","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-20T05:33:33.888151Z","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-20T05:33:33.889665Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-03-20T05:33:33.889883Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","added-peer-id":"1c917701ce165bac","added-peer-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-03-20T05:33:33.889888Z","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-20T05:33:33.890014Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-03-20T05:33:33.890059Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-03-20T05:33:33.890425Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1c917701ce165bac","initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-20T05:33:33.890499Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-20T05:33:34.470708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-03-20T05:33:34.470774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-03-20T05:33:34.470823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-03-20T05:33:34.470843Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-03-20T05:33:34.470855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-03-20T05:33:34.470872Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-03-20T05:33:34.470889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-03-20T05:33:34.471915Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1c917701ce165bac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.169:2379]}","request-path":"/0/members/1c917701ce165bac/attributes","cluster-id":"bfb5247022b87cb1","publish-timeout":"7s"} {"level":"info","ts":"2026-03-20T05:33:34.471916Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-20T05:33:34.471938Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T05:33:34.471972Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-20T05:33:34.472306Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-20T05:33:34.472375Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-20T05:33:34.472808Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T05:33:34.472913Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T05:33:34.472945Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T05:33:34.475248Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"info","ts":"2026-03-20T05:33:34.476Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-20T05:34:08.069218Z","caller":"traceutil/trace.go:171","msg":"trace[247121970] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"144.30879ms","start":"2026-03-20T05:34:07.924883Z","end":"2026-03-20T05:34:08.069192Z","steps":["trace[247121970] 'process raft request' (duration: 144.111606ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:34:08.565209Z","caller":"traceutil/trace.go:171","msg":"trace[6331954] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"120.482067ms","start":"2026-03-20T05:34:08.444685Z","end":"2026-03-20T05:34:08.565167Z","steps":["trace[6331954] 'process raft request' (duration: 120.005657ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:34:27.887211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.365158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-03-20T05:34:27.887403Z","caller":"traceutil/trace.go:171","msg":"trace[1549484635] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:924; }","duration":"104.577333ms","start":"2026-03-20T05:34:27.782763Z","end":"2026-03-20T05:34:27.88734Z","steps":["trace[1549484635] 'range keys from in-memory index tree' (duration: 104.183845ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:35:25.13278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.600569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"info","ts":"2026-03-20T05:35:25.132905Z","caller":"traceutil/trace.go:171","msg":"trace[1282304572] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1610; }","duration":"292.757312ms","start":"2026-03-20T05:35:24.840123Z","end":"2026-03-20T05:35:25.13288Z","steps":["trace[1282304572] 'range keys from in-memory index tree' (duration: 292.362662ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:35:25.133818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.735003ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-20T05:35:25.134023Z","caller":"traceutil/trace.go:171","msg":"trace[119101338] transaction","detail":"{read_only:false; response_revision:1611; number_of_response:1; }","duration":"263.610007ms","start":"2026-03-20T05:35:24.870346Z","end":"2026-03-20T05:35:25.133956Z","steps":["trace[119101338] 'process raft request' (duration: 125.890122ms)","trace[119101338] 'compare' (duration: 136.521548ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:35:25.520797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.339835ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-20T05:35:25.521128Z","caller":"traceutil/trace.go:171","msg":"trace[464772466] transaction","detail":"{read_only:false; response_revision:1614; number_of_response:1; }","duration":"332.43768ms","start":"2026-03-20T05:35:25.18865Z","end":"2026-03-20T05:35:25.521088Z","steps":["trace[464772466] 'process raft request' (duration: 51.622124ms)","trace[464772466] 'compare' (duration: 279.570107ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:35:25.521267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:25.188633Z","time spent":"332.574142ms","remote":"127.0.0.1:54206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T05:35:25.521492Z","caller":"traceutil/trace.go:171","msg":"trace[790599960] transaction","detail":"{read_only:false; response_revision:1615; number_of_response:1; }","duration":"332.586752ms","start":"2026-03-20T05:35:25.188836Z","end":"2026-03-20T05:35:25.521423Z","steps":["trace[790599960] 'process raft request' (duration: 332.148182ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:35:25.521747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:25.188814Z","time spent":"332.791626ms","remote":"127.0.0.1:54206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T05:35:25.521698Z","caller":"traceutil/trace.go:171","msg":"trace[1585177199] transaction","detail":"{read_only:false; response_revision:1617; number_of_response:1; }","duration":"332.454589ms","start":"2026-03-20T05:35:25.189205Z","end":"2026-03-20T05:35:25.52166Z","steps":["trace[1585177199] 'process raft request' (duration: 332.229874ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:35:25.521793Z","caller":"traceutil/trace.go:171","msg":"trace[2076680807] transaction","detail":"{read_only:false; response_revision:1618; number_of_response:1; }","duration":"329.745386ms","start":"2026-03-20T05:35:25.192014Z","end":"2026-03-20T05:35:25.52176Z","steps":["trace[2076680807] 'process raft request' (duration: 329.514451ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:35:25.521927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:25.189182Z","time spent":"332.681824ms","remote":"127.0.0.1:54114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T05:35:25.522011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:25.192007Z","time spent":"329.92111ms","remote":"127.0.0.1:54128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T05:35:25.52205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.245068ms","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-20T05:35:25.522112Z","caller":"traceutil/trace.go:171","msg":"trace[1917430316] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1618; }","duration":"269.342911ms","start":"2026-03-20T05:35:25.25275Z","end":"2026-03-20T05:35:25.522093Z","steps":["trace[1917430316] 'agreement among raft nodes before linearized reading' (duration: 269.147505ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:35:25.522309Z","caller":"traceutil/trace.go:171","msg":"trace[1691498667] linearizableReadLoop","detail":"{readStateIndex:1678; appliedIndex:1673; }","duration":"268.807828ms","start":"2026-03-20T05:35:25.252806Z","end":"2026-03-20T05:35:25.521614Z","steps":["trace[1691498667] 'read index received' (duration: 67.106002ms)","trace[1691498667] 'applied index is now lower than readState.Index' (duration: 201.700926ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:35:25.521625Z","caller":"traceutil/trace.go:171","msg":"trace[380671333] transaction","detail":"{read_only:false; response_revision:1616; number_of_response:1; }","duration":"332.467859ms","start":"2026-03-20T05:35:25.189131Z","end":"2026-03-20T05:35:25.521599Z","steps":["trace[380671333] 'process raft request' (duration: 332.191063ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:35:25.522863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:35:25.189119Z","time spent":"333.478923ms","remote":"127.0.0.1:54114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T05:36:16.649526Z","caller":"traceutil/trace.go:171","msg":"trace[226059069] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"115.477021ms","start":"2026-03-20T05:36:16.534013Z","end":"2026-03-20T05:36:16.649491Z","steps":["trace[226059069] 'process raft request' (duration: 101.697592ms)","trace[226059069] 'compare' (duration: 13.642006ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:37:40.845574Z","caller":"traceutil/trace.go:171","msg":"trace[1433284263] transaction","detail":"{read_only:false; response_revision:2525; number_of_response:1; }","duration":"118.061405ms","start":"2026-03-20T05:37:40.727481Z","end":"2026-03-20T05:37:40.845542Z","steps":["trace[1433284263] 'process raft request' (duration: 100.833553ms)","trace[1433284263] 'compare' (duration: 17.11277ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:37:41.140883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.589434ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-20T05:37:41.141077Z","caller":"traceutil/trace.go:171","msg":"trace[411289440] transaction","detail":"{read_only:false; response_revision:2527; number_of_response:1; }","duration":"212.498669ms","start":"2026-03-20T05:37:40.928561Z","end":"2026-03-20T05:37:41.141059Z","steps":["trace[411289440] 'process raft request' (duration: 212.430357ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:37:41.141103Z","caller":"traceutil/trace.go:171","msg":"trace[1704025129] linearizableReadLoop","detail":"{readStateIndex:2623; appliedIndex:2622; }","duration":"214.028524ms","start":"2026-03-20T05:37:40.927048Z","end":"2026-03-20T05:37:41.141077Z","steps":["trace[1704025129] 'read index received' (duration: 84.169755ms)","trace[1704025129] 'applied index is now lower than readState.Index' (duration: 129.857299ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:37:41.141248Z","caller":"traceutil/trace.go:171","msg":"trace[489082362] transaction","detail":"{read_only:false; response_revision:2526; number_of_response:1; }","duration":"215.345065ms","start":"2026-03-20T05:37:40.925888Z","end":"2026-03-20T05:37:41.141233Z","steps":["trace[489082362] 'process raft request' (duration: 85.318041ms)","trace[489082362] 'compare' (duration: 129.41061ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T05:37:41.141399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.347411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T05:37:41.141457Z","caller":"traceutil/trace.go:171","msg":"trace[1721757556] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2527; }","duration":"214.425053ms","start":"2026-03-20T05:37:40.927019Z","end":"2026-03-20T05:37:41.141444Z","steps":["trace[1721757556] 'agreement among raft nodes before linearized reading' (duration: 214.346501ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:40:12.402388Z","caller":"traceutil/trace.go:171","msg":"trace[1794263215] linearizableReadLoop","detail":"{readStateIndex:3586; appliedIndex:3585; }","duration":"180.130504ms","start":"2026-03-20T05:40:12.222229Z","end":"2026-03-20T05:40:12.40236Z","steps":["trace[1794263215] 'read index received' (duration: 179.97255ms)","trace[1794263215] 'applied index is now lower than readState.Index' (duration: 156.664µs)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:40:12.402473Z","caller":"traceutil/trace.go:171","msg":"trace[2134799424] transaction","detail":"{read_only:false; response_revision:3452; number_of_response:1; }","duration":"206.796394ms","start":"2026-03-20T05:40:12.19565Z","end":"2026-03-20T05:40:12.402446Z","steps":["trace[2134799424] 'process raft request' (duration: 206.525448ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:40:12.402684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.432003ms","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":"warn","ts":"2026-03-20T05:40:12.402673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.054677ms","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-20T05:40:12.402743Z","caller":"traceutil/trace.go:171","msg":"trace[1099984892] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3452; }","duration":"180.544095ms","start":"2026-03-20T05:40:12.222183Z","end":"2026-03-20T05:40:12.402727Z","steps":["trace[1099984892] 'agreement among raft nodes before linearized reading' (duration: 180.35669ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:40:12.402776Z","caller":"traceutil/trace.go:171","msg":"trace[718507076] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:3452; }","duration":"145.21363ms","start":"2026-03-20T05:40:12.257535Z","end":"2026-03-20T05:40:12.402748Z","steps":["trace[718507076] 'agreement among raft nodes before linearized reading' (duration: 145.046426ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:41:36.712627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.659624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:1229"} {"level":"info","ts":"2026-03-20T05:41:36.712756Z","caller":"traceutil/trace.go:171","msg":"trace[873851458] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4563; }","duration":"319.840229ms","start":"2026-03-20T05:41:36.392894Z","end":"2026-03-20T05:41:36.712734Z","steps":["trace[873851458] 'range keys from in-memory index tree' (duration: 319.46906ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:41:36.712797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:41:36.392876Z","time spent":"319.911091ms","remote":"127.0.0.1:54146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1252,"request content":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager\" "} {"level":"warn","ts":"2026-03-20T05:41:36.713063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.862429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fdghj\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-03-20T05:41:36.713091Z","caller":"traceutil/trace.go:171","msg":"trace[398355564] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fdghj; range_end:; response_count:1; response_revision:4563; }","duration":"294.957891ms","start":"2026-03-20T05:41:36.418125Z","end":"2026-03-20T05:41:36.713083Z","steps":["trace[398355564] 'range keys from in-memory index tree' (duration: 294.669605ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:41:36.734541Z","caller":"traceutil/trace.go:171","msg":"trace[886585532] transaction","detail":"{read_only:false; response_revision:4564; number_of_response:1; }","duration":"149.652256ms","start":"2026-03-20T05:41:36.584868Z","end":"2026-03-20T05:41:36.73452Z","steps":["trace[886585532] 'process raft request' (duration: 149.339419ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:41:48.022104Z","caller":"traceutil/trace.go:171","msg":"trace[1866744558] transaction","detail":"{read_only:false; response_revision:4791; number_of_response:1; }","duration":"120.956489ms","start":"2026-03-20T05:41:47.901114Z","end":"2026-03-20T05:41:48.02207Z","steps":["trace[1866744558] 'process raft request' (duration: 120.653741ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:41:48.026787Z","caller":"traceutil/trace.go:171","msg":"trace[1797529642] transaction","detail":"{read_only:false; response_revision:4792; number_of_response:1; }","duration":"123.325495ms","start":"2026-03-20T05:41:47.90343Z","end":"2026-03-20T05:41:48.026756Z","steps":["trace[1797529642] 'process raft request' (duration: 123.0991ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:41:56.641236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.970289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T05:41:56.641351Z","caller":"traceutil/trace.go:171","msg":"trace[1900739492] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4971; }","duration":"151.106022ms","start":"2026-03-20T05:41:56.490222Z","end":"2026-03-20T05:41:56.641328Z","steps":["trace[1900739492] 'range keys from in-memory index tree' (duration: 150.885076ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:41:58.200181Z","caller":"traceutil/trace.go:171","msg":"trace[98825923] transaction","detail":"{read_only:false; response_revision:4980; number_of_response:1; }","duration":"124.360156ms","start":"2026-03-20T05:41:58.075799Z","end":"2026-03-20T05:41:58.200159Z","steps":["trace[98825923] 'process raft request' (duration: 123.769572ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:41:58.202267Z","caller":"traceutil/trace.go:171","msg":"trace[1064260792] linearizableReadLoop","detail":"{readStateIndex:5169; appliedIndex:5167; }","duration":"101.80123ms","start":"2026-03-20T05:41:58.10044Z","end":"2026-03-20T05:41:58.202241Z","steps":["trace[1064260792] 'read index received' (duration: 99.140977ms)","trace[1064260792] 'applied index is now lower than readState.Index' (duration: 2.659143ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:41:58.202393Z","caller":"traceutil/trace.go:171","msg":"trace[809586365] transaction","detail":"{read_only:false; response_revision:4981; number_of_response:1; }","duration":"121.916108ms","start":"2026-03-20T05:41:58.080449Z","end":"2026-03-20T05:41:58.202366Z","steps":["trace[809586365] 'process raft request' (duration: 121.651252ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:41:58.202524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.939913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T05:41:58.202585Z","caller":"traceutil/trace.go:171","msg":"trace[241194288] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:4981; }","duration":"102.174089ms","start":"2026-03-20T05:41:58.100394Z","end":"2026-03-20T05:41:58.202568Z","steps":["trace[241194288] 'agreement among raft nodes before linearized reading' (duration: 101.953504ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:43:34.497501Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2793} {"level":"info","ts":"2026-03-20T05:43:34.557679Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2793,"took":"59.083226ms","hash":1445056858,"current-db-size-bytes":41971712,"current-db-size":"42 MB","current-db-size-in-use-bytes":31285248,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-03-20T05:43:34.55774Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1445056858,"revision":2793,"compact-revision":-1} {"level":"info","ts":"2026-03-20T05:48:17.889314Z","caller":"traceutil/trace.go:171","msg":"trace[1084352598] transaction","detail":"{read_only:false; response_revision:7692; number_of_response:1; }","duration":"150.806759ms","start":"2026-03-20T05:48:17.738477Z","end":"2026-03-20T05:48:17.889284Z","steps":["trace[1084352598] 'process raft request' (duration: 150.765157ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:48:17.891179Z","caller":"traceutil/trace.go:171","msg":"trace[1973090835] transaction","detail":"{read_only:false; response_revision:7691; number_of_response:1; }","duration":"153.665677ms","start":"2026-03-20T05:48:17.735667Z","end":"2026-03-20T05:48:17.889333Z","steps":["trace[1973090835] 'process raft request' (duration: 153.4209ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:48:17.976259Z","caller":"traceutil/trace.go:171","msg":"trace[580396906] transaction","detail":"{read_only:false; response_revision:7693; number_of_response:1; }","duration":"120.327844ms","start":"2026-03-20T05:48:17.855892Z","end":"2026-03-20T05:48:17.97622Z","steps":["trace[580396906] 'process raft request' (duration: 114.427692ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:48:20.014383Z","caller":"traceutil/trace.go:171","msg":"trace[207962017] transaction","detail":"{read_only:false; response_revision:7705; number_of_response:1; }","duration":"109.749538ms","start":"2026-03-20T05:48:19.904557Z","end":"2026-03-20T05:48:20.014306Z","steps":["trace[207962017] 'process raft request' (duration: 107.381832ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:48:34.521399Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5787} {"level":"info","ts":"2026-03-20T05:48:34.612774Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5787,"took":"89.485457ms","hash":2373250435,"current-db-size-bytes":43401216,"current-db-size":"43 MB","current-db-size-in-use-bytes":23056384,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-03-20T05:48:34.61286Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2373250435,"revision":5787,"compact-revision":2793} {"level":"info","ts":"2026-03-20T05:48:43.487822Z","caller":"traceutil/trace.go:171","msg":"trace[1312475847] linearizableReadLoop","detail":"{readStateIndex:8162; appliedIndex:8161; }","duration":"121.235312ms","start":"2026-03-20T05:48:43.366555Z","end":"2026-03-20T05:48:43.48779Z","steps":["trace[1312475847] 'read index received' (duration: 120.987926ms)","trace[1312475847] 'applied index is now lower than readState.Index' (duration: 246.346µs)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:48:43.487965Z","caller":"traceutil/trace.go:171","msg":"trace[1431764821] transaction","detail":"{read_only:false; response_revision:7872; number_of_response:1; }","duration":"141.459442ms","start":"2026-03-20T05:48:43.346462Z","end":"2026-03-20T05:48:43.487922Z","steps":["trace[1431764821] 'process raft request' (duration: 141.156865ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:48:43.488103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.523888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/rook-ceph/rook-ceph-csi-config\" ","response":"range_response_count:1 size:512"} {"level":"info","ts":"2026-03-20T05:48:43.488151Z","caller":"traceutil/trace.go:171","msg":"trace[648235769] range","detail":"{range_begin:/registry/configmaps/rook-ceph/rook-ceph-csi-config; range_end:; response_count:1; response_revision:7872; }","duration":"121.637271ms","start":"2026-03-20T05:48:43.3665Z","end":"2026-03-20T05:48:43.488137Z","steps":["trace[648235769] 'agreement among raft nodes before linearized reading' (duration: 121.433186ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:48:50.341138Z","caller":"traceutil/trace.go:171","msg":"trace[1708557292] transaction","detail":"{read_only:false; response_revision:7904; number_of_response:1; }","duration":"332.967596ms","start":"2026-03-20T05:48:50.008117Z","end":"2026-03-20T05:48:50.341085Z","steps":["trace[1708557292] 'process raft request' (duration: 332.803692ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:48:50.341326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:48:50.008083Z","time spent":"333.148359ms","remote":"127.0.0.1:54200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T05:48:50.409822Z","caller":"traceutil/trace.go:171","msg":"trace[895631411] transaction","detail":"{read_only:false; response_revision:7905; number_of_response:1; }","duration":"333.115988ms","start":"2026-03-20T05:48:50.076628Z","end":"2026-03-20T05:48:50.409744Z","steps":["trace[895631411] 'process raft request' (duration: 332.522864ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:48:50.409941Z","caller":"traceutil/trace.go:171","msg":"trace[1150342107] transaction","detail":"{read_only:false; response_revision:7906; number_of_response:1; }","duration":"179.557568ms","start":"2026-03-20T05:48:50.23031Z","end":"2026-03-20T05:48:50.409867Z","steps":["trace[1150342107] 'process raft request' (duration: 178.977925ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:48:50.410047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T05:48:50.076601Z","time spent":"333.330654ms","remote":"127.0.0.1:54200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T05:49:00.609915Z","caller":"traceutil/trace.go:171","msg":"trace[572619025] linearizableReadLoop","detail":"{readStateIndex:8296; appliedIndex:8294; }","duration":"124.882568ms","start":"2026-03-20T05:49:00.485002Z","end":"2026-03-20T05:49:00.609884Z","steps":["trace[572619025] 'read index received' (duration: 85.597624ms)","trace[572619025] 'applied index is now lower than readState.Index' (duration: 39.283614ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:49:00.610005Z","caller":"traceutil/trace.go:171","msg":"trace[115313720] transaction","detail":"{read_only:false; response_revision:8000; number_of_response:1; }","duration":"157.553335ms","start":"2026-03-20T05:49:00.452431Z","end":"2026-03-20T05:49:00.609984Z","steps":["trace[115313720] 'process raft request' (duration: 118.115217ms)","trace[115313720] 'compare' (duration: 38.988467ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T05:49:00.610057Z","caller":"traceutil/trace.go:171","msg":"trace[570039189] transaction","detail":"{read_only:false; response_revision:8001; number_of_response:1; }","duration":"155.375463ms","start":"2026-03-20T05:49:00.45467Z","end":"2026-03-20T05:49:00.610045Z","steps":["trace[570039189] 'process raft request' (duration: 155.150798ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:49:00.610285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.269628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-03-20T05:49:00.610326Z","caller":"traceutil/trace.go:171","msg":"trace[1621888931] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8001; }","duration":"125.36836ms","start":"2026-03-20T05:49:00.484945Z","end":"2026-03-20T05:49:00.610313Z","steps":["trace[1621888931] 'agreement among raft nodes before linearized reading' (duration: 125.215126ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:49:00.610427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.90373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T05:49:00.610456Z","caller":"traceutil/trace.go:171","msg":"trace[358762106] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8001; }","duration":"119.981273ms","start":"2026-03-20T05:49:00.490467Z","end":"2026-03-20T05:49:00.610448Z","steps":["trace[358762106] 'agreement among raft nodes before linearized reading' (duration: 119.938542ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:49:00.610659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.559185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-03-20T05:49:00.610694Z","caller":"traceutil/trace.go:171","msg":"trace[1731007451] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8001; }","duration":"101.616476ms","start":"2026-03-20T05:49:00.509069Z","end":"2026-03-20T05:49:00.610686Z","steps":["trace[1731007451] 'agreement among raft nodes before linearized reading' (duration: 101.527764ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:49:00.611606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.544158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2210989"} {"level":"info","ts":"2026-03-20T05:49:00.61166Z","caller":"traceutil/trace.go:171","msg":"trace[1957806328] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:8001; }","duration":"102.645691ms","start":"2026-03-20T05:49:00.509002Z","end":"2026-03-20T05:49:00.611648Z","steps":["trace[1957806328] 'agreement among raft nodes before linearized reading' (duration: 101.704989ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:49:00.897247Z","caller":"traceutil/trace.go:171","msg":"trace[327490737] transaction","detail":"{read_only:false; response_revision:8005; number_of_response:1; }","duration":"107.191558ms","start":"2026-03-20T05:49:00.790021Z","end":"2026-03-20T05:49:00.897213Z","steps":["trace[327490737] 'process raft request' (duration: 106.980403ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T05:50:18.014352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.008335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fdghj\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-03-20T05:50:18.014471Z","caller":"traceutil/trace.go:171","msg":"trace[1217165874] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fdghj; range_end:; response_count:1; response_revision:8716; }","duration":"158.19314ms","start":"2026-03-20T05:50:17.856252Z","end":"2026-03-20T05:50:18.014445Z","steps":["trace[1217165874] 'range keys from in-memory index tree' (duration: 157.729619ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:52:30.7156Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1c917701ce165bac","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-20T05:52:30.72032Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-20T05:52:30.720426Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-20T05:52:35.787529Z","caller":"traceutil/trace.go:171","msg":"trace[1570812832] transaction","detail":"{read_only:false; response_revision:9695; number_of_response:1; }","duration":"116.528491ms","start":"2026-03-20T05:52:35.670956Z","end":"2026-03-20T05:52:35.787484Z","steps":["trace[1570812832] 'process raft request' (duration: 116.272925ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T05:53:34.529073Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7779} {"level":"info","ts":"2026-03-20T05:53:34.591156Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7779,"took":"58.696896ms","hash":3292043196,"current-db-size-bytes":43401216,"current-db-size":"43 MB","current-db-size-in-use-bytes":25800704,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-03-20T05:53:34.591288Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3292043196,"revision":7779,"compact-revision":5787} {"level":"info","ts":"2026-03-20T05:58:34.538163Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10022} {"level":"info","ts":"2026-03-20T05:58:34.619678Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10022,"took":"78.556952ms","hash":788387000,"current-db-size-bytes":43401216,"current-db-size":"43 MB","current-db-size-in-use-bytes":17600512,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-03-20T05:58:34.61976Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":788387000,"revision":10022,"compact-revision":7779}