{"level":"warn","ts":"2026-07-14T17:41:55.86718Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-14T17:41:55.867266Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.48: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.19.213.48:2380","--initial-cluster=instance=https://199.19.213.48:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.48:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.48: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-07-14T17:41:55.867334Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-14T17:41:55.867347Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.48:2380"]} {"level":"info","ts":"2026-07-14T17:41:55.867371Z","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-07-14T17:41:55.868073Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.48:2379"]} {"level":"info","ts":"2026-07-14T17:41:55.868156Z","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.19.213.48:2380"],"listen-peer-urls":["https://199.19.213.48:2380"],"advertise-client-urls":["https://199.19.213.48:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.48:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.48: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-07-14T17:41:55.872706Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.319572ms"} {"level":"info","ts":"2026-07-14T17:41:55.88229Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7317567213c7319d","cluster-id":"d22ed1e1757a8527"} {"level":"info","ts":"2026-07-14T17:41:55.882362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d switched to configuration voters=()"} {"level":"info","ts":"2026-07-14T17:41:55.882384Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d became follower at term 0"} {"level":"info","ts":"2026-07-14T17:41:55.88241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7317567213c7319d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-14T17:41:55.882418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d became follower at term 1"} {"level":"info","ts":"2026-07-14T17:41:55.882454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d switched to configuration voters=(8293192286784139677)"} {"level":"warn","ts":"2026-07-14T17:41:55.897321Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-14T17:41:55.90305Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-14T17:41:55.90626Z","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-07-14T17:41:55.910218Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7317567213c7319d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-14T17:41:55.910302Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7317567213c7319d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-14T17:41:55.910555Z","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-07-14T17:41:55.910627Z","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-07-14T17:41:55.91064Z","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-07-14T17:41:55.912662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d switched to configuration voters=(8293192286784139677)"} {"level":"info","ts":"2026-07-14T17:41:55.91378Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d22ed1e1757a8527","local-member-id":"7317567213c7319d","added-peer-id":"7317567213c7319d","added-peer-peer-urls":["https://199.19.213.48:2380"]} {"level":"info","ts":"2026-07-14T17:41:55.923099Z","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-07-14T17:41:55.923237Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.48:2380"} {"level":"info","ts":"2026-07-14T17:41:55.923302Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.48:2380"} {"level":"info","ts":"2026-07-14T17:41:55.923339Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7317567213c7319d","initial-advertise-peer-urls":["https://199.19.213.48:2380"],"listen-peer-urls":["https://199.19.213.48:2380"],"advertise-client-urls":["https://199.19.213.48:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.48:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-14T17:41:55.923379Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-14T17:41:56.88351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d is starting a new election at term 1"} {"level":"info","ts":"2026-07-14T17:41:56.883593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d became pre-candidate at term 1"} {"level":"info","ts":"2026-07-14T17:41:56.883635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d received MsgPreVoteResp from 7317567213c7319d at term 1"} {"level":"info","ts":"2026-07-14T17:41:56.883654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d became candidate at term 2"} {"level":"info","ts":"2026-07-14T17:41:56.883672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d received MsgVoteResp from 7317567213c7319d at term 2"} {"level":"info","ts":"2026-07-14T17:41:56.883687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7317567213c7319d became leader at term 2"} {"level":"info","ts":"2026-07-14T17:41:56.8837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7317567213c7319d elected leader 7317567213c7319d at term 2"} {"level":"info","ts":"2026-07-14T17:41:56.884971Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7317567213c7319d","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.48:2379]}","request-path":"/0/members/7317567213c7319d/attributes","cluster-id":"d22ed1e1757a8527","publish-timeout":"7s"} {"level":"info","ts":"2026-07-14T17:41:56.885149Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-14T17:41:56.885214Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T17:41:56.885352Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-14T17:41:56.885637Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-14T17:41:56.885812Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-14T17:41:56.885948Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d22ed1e1757a8527","local-member-id":"7317567213c7319d","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T17:41:56.886044Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T17:41:56.88606Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T17:41:56.889243Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.48:2379"} {"level":"info","ts":"2026-07-14T17:41:56.889807Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-14T17:41:58.555708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.45819ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-14T17:41:58.555978Z","caller":"traceutil/trace.go:171","msg":"trace[165831704] linearizableReadLoop","detail":"{readStateIndex:64; appliedIndex:61; }","duration":"129.358923ms","start":"2026-07-14T17:41:58.426608Z","end":"2026-07-14T17:41:58.555967Z","steps":["trace[165831704] 'read index received' (duration: 37.031µs)","trace[165831704] 'applied index is now lower than readState.Index' (duration: 129.321292ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:41:58.556077Z","caller":"traceutil/trace.go:171","msg":"trace[382970949] transaction","detail":"{read_only:false; response_revision:58; number_of_response:1; }","duration":"258.392706ms","start":"2026-07-14T17:41:58.297669Z","end":"2026-07-14T17:41:58.556062Z","steps":["trace[382970949] 'process raft request' (duration: 258.219511ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:41:58.556247Z","caller":"traceutil/trace.go:171","msg":"trace[1863781854] transaction","detail":"{read_only:false; response_revision:57; number_of_response:1; }","duration":"258.606672ms","start":"2026-07-14T17:41:58.297626Z","end":"2026-07-14T17:41:58.556233Z","steps":["trace[1863781854] 'process raft request' (duration: 15.295066ms)","trace[1863781854] 'compare' (duration: 242.377278ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:41:58.556682Z","caller":"traceutil/trace.go:171","msg":"trace[124335483] transaction","detail":"{read_only:false; response_revision:59; number_of_response:1; }","duration":"253.736233ms","start":"2026-07-14T17:41:58.302935Z","end":"2026-07-14T17:41:58.556671Z","steps":["trace[124335483] 'process raft request' (duration: 252.997461ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:41:58.556684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.645982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-14T17:41:58.556912Z","caller":"traceutil/trace.go:171","msg":"trace[178233621] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:59; }","duration":"130.200668ms","start":"2026-07-14T17:41:58.426602Z","end":"2026-07-14T17:41:58.556803Z","steps":["trace[178233621] 'agreement among raft nodes before linearized reading' (duration: 129.569249ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:41:58.904218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.701673ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-14T17:41:58.904314Z","caller":"traceutil/trace.go:171","msg":"trace[1457570270] linearizableReadLoop","detail":"{readStateIndex:65; appliedIndex:64; }","duration":"344.841852ms","start":"2026-07-14T17:41:58.559457Z","end":"2026-07-14T17:41:58.904299Z","steps":["trace[1457570270] 'read index received' (duration: 111.037855ms)","trace[1457570270] 'applied index is now lower than readState.Index' (duration: 233.802676ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:41:58.90456Z","caller":"traceutil/trace.go:171","msg":"trace[1332314434] transaction","detail":"{read_only:false; response_revision:60; number_of_response:1; }","duration":"345.218453ms","start":"2026-07-14T17:41:58.559313Z","end":"2026-07-14T17:41:58.904531Z","steps":["trace[1332314434] 'process raft request' (duration: 111.140498ms)","trace[1332314434] 'compare' (duration: 233.564249ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T17:41:58.904641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:41:58.559299Z","time spent":"345.307785ms","remote":"127.0.0.1:38260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":702,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-14T17:41:58.905045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.574194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3490"} {"level":"info","ts":"2026-07-14T17:41:58.905123Z","caller":"traceutil/trace.go:171","msg":"trace[1814604585] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:60; }","duration":"345.684777ms","start":"2026-07-14T17:41:58.559422Z","end":"2026-07-14T17:41:58.905107Z","steps":["trace[1814604585] 'agreement among raft nodes before linearized reading' (duration: 344.920154ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:41:58.905348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:41:58.559409Z","time spent":"345.927434ms","remote":"127.0.0.1:37972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3513,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-07-14T17:41:58.994133Z","caller":"traceutil/trace.go:171","msg":"trace[1712185449] transaction","detail":"{read_only:false; response_revision:61; number_of_response:1; }","duration":"434.307408ms","start":"2026-07-14T17:41:58.559788Z","end":"2026-07-14T17:41:58.994096Z","steps":["trace[1712185449] 'process raft request' (duration: 433.854574ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:41:58.994355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:41:58.559778Z","time spent":"434.509934ms","remote":"127.0.0.1:37986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3453,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-14T17:41:58.994813Z","caller":"traceutil/trace.go:171","msg":"trace[803161292] transaction","detail":"{read_only:false; response_revision:63; number_of_response:1; }","duration":"433.268626ms","start":"2026-07-14T17:41:58.561527Z","end":"2026-07-14T17:41:58.994796Z","steps":["trace[803161292] 'process raft request' (duration: 433.182673ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:41:58.995069Z","caller":"traceutil/trace.go:171","msg":"trace[688307218] transaction","detail":"{read_only:false; response_revision:62; number_of_response:1; }","duration":"435.03016ms","start":"2026-07-14T17:41:58.560024Z","end":"2026-07-14T17:41:58.995054Z","steps":["trace[688307218] 'process raft request' (duration: 433.781942ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:41:58.995219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:41:58.559999Z","time spent":"435.176714ms","remote":"127.0.0.1:37876","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-14T17:41:58.9955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:41:58.561517Z","time spent":"433.355039ms","remote":"127.0.0.1:38260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1089,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T17:41:59.011762Z","caller":"traceutil/trace.go:171","msg":"trace[1247333813] transaction","detail":"{read_only:false; response_revision:65; number_of_response:1; }","duration":"102.954798ms","start":"2026-07-14T17:41:58.908785Z","end":"2026-07-14T17:41:59.01174Z","steps":["trace[1247333813] 'process raft request' (duration: 102.824214ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:41:59.011794Z","caller":"traceutil/trace.go:171","msg":"trace[1060777930] transaction","detail":"{read_only:false; response_revision:64; number_of_response:1; }","duration":"103.200496ms","start":"2026-07-14T17:41:58.908575Z","end":"2026-07-14T17:41:59.011775Z","steps":["trace[1060777930] 'process raft request' (duration: 98.602145ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:42:21.760947Z","caller":"traceutil/trace.go:171","msg":"trace[903054372] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"107.51751ms","start":"2026-07-14T17:42:21.653396Z","end":"2026-07-14T17:42:21.760914Z","steps":["trace[903054372] 'process raft request' (duration: 80.755636ms)","trace[903054372] 'compare' (duration: 26.407113ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:42:42.190505Z","caller":"traceutil/trace.go:171","msg":"trace[817108286] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"142.814562ms","start":"2026-07-14T17:42:42.047653Z","end":"2026-07-14T17:42:42.190468Z","steps":["trace[817108286] 'process raft request' (duration: 72.714337ms)","trace[817108286] 'compare' (duration: 69.738544ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T17:42:42.765452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.449505ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-14T17:42:42.765583Z","caller":"traceutil/trace.go:171","msg":"trace[1314457492] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"495.906941ms","start":"2026-07-14T17:42:42.26963Z","end":"2026-07-14T17:42:42.765537Z","steps":["trace[1314457492] 'process raft request' (duration: 282.314672ms)","trace[1314457492] 'compare' (duration: 213.356082ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:42:42.765669Z","caller":"traceutil/trace.go:171","msg":"trace[2054151146] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"341.457478ms","start":"2026-07-14T17:42:42.424153Z","end":"2026-07-14T17:42:42.765611Z","steps":["trace[2054151146] 'process raft request' (duration: 341.388416ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:42:42.765757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:42:42.269595Z","time spent":"496.070656ms","remote":"127.0.0.1:38148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-14T17:42:42.765776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:42:42.424132Z","time spent":"341.607643ms","remote":"127.0.0.1:38094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T17:42:42.766921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.953311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-14T17:42:42.766979Z","caller":"traceutil/trace.go:171","msg":"trace[1480838710] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:633; }","duration":"349.067444ms","start":"2026-07-14T17:42:42.4179Z","end":"2026-07-14T17:42:42.766967Z","steps":["trace[1480838710] 'agreement among raft nodes before linearized reading' (duration: 348.927509ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:42:42.76702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:42:42.417875Z","time spent":"349.133676ms","remote":"127.0.0.1:38094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-14T17:42:42.766743Z","caller":"traceutil/trace.go:171","msg":"trace[1388073101] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"348.368502ms","start":"2026-07-14T17:42:42.417955Z","end":"2026-07-14T17:42:42.766324Z","steps":["trace[1388073101] 'read index received' (duration: 134.03278ms)","trace[1388073101] 'applied index is now lower than readState.Index' (duration: 214.332762ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T17:42:42.768194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.527612ms","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-07-14T17:42:42.768274Z","caller":"traceutil/trace.go:171","msg":"trace[657552224] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:633; }","duration":"247.657257ms","start":"2026-07-14T17:42:42.520597Z","end":"2026-07-14T17:42:42.768254Z","steps":["trace[657552224] 'agreement among raft nodes before linearized reading' (duration: 246.845692ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:43:12.214076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:43:11.907277Z","time spent":"306.784928ms","remote":"127.0.0.1:33108","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-14T17:44:28.661971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.656201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a3902492-e0c1-499d-a691-440fccb85ade\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-07-14T17:44:28.662222Z","caller":"traceutil/trace.go:171","msg":"trace[1011617658] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a3902492-e0c1-499d-a691-440fccb85ade; range_end:; response_count:1; response_revision:1935; }","duration":"334.973322ms","start":"2026-07-14T17:44:28.327222Z","end":"2026-07-14T17:44:28.662195Z","steps":["trace[1011617658] 'range keys from in-memory index tree' (duration: 334.365082ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:44:28.662361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:44:28.327194Z","time spent":"335.145547ms","remote":"127.0.0.1:37986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a3902492-e0c1-499d-a691-440fccb85ade\" "} {"level":"info","ts":"2026-07-14T17:44:56.597781Z","caller":"traceutil/trace.go:171","msg":"trace[766936263] linearizableReadLoop","detail":"{readStateIndex:2219; appliedIndex:2218; }","duration":"127.462848ms","start":"2026-07-14T17:44:56.470298Z","end":"2026-07-14T17:44:56.597761Z","steps":["trace[766936263] 'read index received' (duration: 103.543885ms)","trace[766936263] 'applied index is now lower than readState.Index' (duration: 23.918253ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:44:56.597856Z","caller":"traceutil/trace.go:171","msg":"trace[130488179] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"382.58733ms","start":"2026-07-14T17:44:56.215232Z","end":"2026-07-14T17:44:56.59782Z","steps":["trace[130488179] 'process raft request' (duration: 358.623075ms)","trace[130488179] 'compare' (duration: 23.641365ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T17:44:56.597934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.621173ms","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-07-14T17:44:56.597969Z","caller":"traceutil/trace.go:171","msg":"trace[786181730] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2139; }","duration":"127.695015ms","start":"2026-07-14T17:44:56.470262Z","end":"2026-07-14T17:44:56.597957Z","steps":["trace[786181730] 'agreement among raft nodes before linearized reading' (duration: 127.572901ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:44:56.598066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:44:56.215212Z","time spent":"382.728684ms","remote":"127.0.0.1:38094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T17:45:03.046399Z","caller":"traceutil/trace.go:171","msg":"trace[430902326] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"142.237442ms","start":"2026-07-14T17:45:02.903992Z","end":"2026-07-14T17:45:03.046229Z","steps":["trace[430902326] 'process raft request' (duration: 124.126244ms)","trace[430902326] 'compare' (duration: 17.938333ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:45:03.493487Z","caller":"traceutil/trace.go:171","msg":"trace[786862682] linearizableReadLoop","detail":"{readStateIndex:2255; appliedIndex:2254; }","duration":"195.355189ms","start":"2026-07-14T17:45:03.298111Z","end":"2026-07-14T17:45:03.493467Z","steps":["trace[786862682] 'read index received' (duration: 195.207634ms)","trace[786862682] 'applied index is now lower than readState.Index' (duration: 146.985µs)"],"step_count":2} {"level":"warn","ts":"2026-07-14T17:45:03.493624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.490473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T17:45:03.493647Z","caller":"traceutil/trace.go:171","msg":"trace[1558259465] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:2174; }","duration":"195.534674ms","start":"2026-07-14T17:45:03.298105Z","end":"2026-07-14T17:45:03.493639Z","steps":["trace[1558259465] 'agreement among raft nodes before linearized reading' (duration: 195.466512ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:45:03.493552Z","caller":"traceutil/trace.go:171","msg":"trace[599299503] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"243.00408ms","start":"2026-07-14T17:45:03.250514Z","end":"2026-07-14T17:45:03.493518Z","steps":["trace[599299503] 'process raft request' (duration: 242.834725ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:45:03.86467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.080089ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T17:45:03.86516Z","caller":"traceutil/trace.go:171","msg":"trace[269691345] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"279.064363ms","start":"2026-07-14T17:45:03.586083Z","end":"2026-07-14T17:45:03.865147Z","steps":["trace[269691345] 'process raft request' (duration: 278.673721ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:45:03.865146Z","caller":"traceutil/trace.go:171","msg":"trace[1734212177] linearizableReadLoop","detail":"{readStateIndex:2256; appliedIndex:2255; }","duration":"323.73862ms","start":"2026-07-14T17:45:03.541362Z","end":"2026-07-14T17:45:03.865101Z","steps":["trace[1734212177] 'read index received' (duration: 103.164695ms)","trace[1734212177] 'applied index is now lower than readState.Index' (duration: 220.571205ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:45:03.865208Z","caller":"traceutil/trace.go:171","msg":"trace[1451685063] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"299.595489ms","start":"2026-07-14T17:45:03.565569Z","end":"2026-07-14T17:45:03.865164Z","steps":["trace[1451685063] 'process raft request' (duration: 299.163975ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:45:03.865292Z","caller":"traceutil/trace.go:171","msg":"trace[1174369912] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"347.029054ms","start":"2026-07-14T17:45:03.518245Z","end":"2026-07-14T17:45:03.865274Z","steps":["trace[1174369912] 'process raft request' (duration: 126.298014ms)","trace[1174369912] 'compare' (duration: 219.980306ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T17:45:03.865392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.986623ms","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":"warn","ts":"2026-07-14T17:45:03.865396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:45:03.51823Z","time spent":"347.111556ms","remote":"127.0.0.1:38094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T17:45:03.865441Z","caller":"traceutil/trace.go:171","msg":"trace[485637798] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2178; }","duration":"218.074205ms","start":"2026-07-14T17:45:03.647349Z","end":"2026-07-14T17:45:03.865423Z","steps":["trace[485637798] 'agreement among raft nodes before linearized reading' (duration: 217.951331ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:45:03.865506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.137132ms","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-07-14T17:45:03.86555Z","caller":"traceutil/trace.go:171","msg":"trace[999050241] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2178; }","duration":"324.222755ms","start":"2026-07-14T17:45:03.541317Z","end":"2026-07-14T17:45:03.86554Z","steps":["trace[999050241] 'agreement among raft nodes before linearized reading' (duration: 324.071ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:45:03.865581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T17:45:03.541299Z","time spent":"324.275627ms","remote":"127.0.0.1:38094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-14T17:45:03.865879Z","caller":"traceutil/trace.go:171","msg":"trace[1860996073] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"123.160013ms","start":"2026-07-14T17:45:03.741646Z","end":"2026-07-14T17:45:03.864806Z","steps":["trace[1860996073] 'process raft request' (duration: 123.137372ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:46:47.486645Z","caller":"traceutil/trace.go:171","msg":"trace[1213250486] transaction","detail":"{read_only:false; response_revision:2838; number_of_response:1; }","duration":"123.267018ms","start":"2026-07-14T17:46:47.363157Z","end":"2026-07-14T17:46:47.486424Z","steps":["trace[1213250486] 'process raft request' (duration: 123.129523ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:46:47.755978Z","caller":"traceutil/trace.go:171","msg":"trace[1758581016] transaction","detail":"{read_only:false; response_revision:2839; number_of_response:1; }","duration":"108.960817ms","start":"2026-07-14T17:46:47.646992Z","end":"2026-07-14T17:46:47.755953Z","steps":["trace[1758581016] 'process raft request' (duration: 108.816123ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:50:47.104811Z","caller":"traceutil/trace.go:171","msg":"trace[1745399625] linearizableReadLoop","detail":"{readStateIndex:5059; appliedIndex:5058; }","duration":"159.774093ms","start":"2026-07-14T17:50:46.945022Z","end":"2026-07-14T17:50:47.104796Z","steps":["trace[1745399625] 'read index received' (duration: 159.628689ms)","trace[1745399625] 'applied index is now lower than readState.Index' (duration: 144.664µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:50:47.105031Z","caller":"traceutil/trace.go:171","msg":"trace[2116841599] transaction","detail":"{read_only:false; response_revision:4878; number_of_response:1; }","duration":"288.255728ms","start":"2026-07-14T17:50:46.81676Z","end":"2026-07-14T17:50:47.105016Z","steps":["trace[2116841599] 'process raft request' (duration: 287.946849ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:50:47.105173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.124812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12973"} {"level":"warn","ts":"2026-07-14T17:50:47.105218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.05206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-68c9fdd89d-hp2g6.18c2395677fa362c\" ","response":"range_response_count:1 size:896"} {"level":"warn","ts":"2026-07-14T17:50:47.105219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.579621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-07-14T17:50:47.105247Z","caller":"traceutil/trace.go:171","msg":"trace[786374995] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4878; }","duration":"160.248066ms","start":"2026-07-14T17:50:46.944985Z","end":"2026-07-14T17:50:47.105233Z","steps":["trace[786374995] 'agreement among raft nodes before linearized reading' (duration: 160.013849ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:50:47.105269Z","caller":"traceutil/trace.go:171","msg":"trace[435945274] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4878; }","duration":"136.639893ms","start":"2026-07-14T17:50:46.968616Z","end":"2026-07-14T17:50:47.105256Z","steps":["trace[435945274] 'agreement among raft nodes before linearized reading' (duration: 136.506579ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:50:47.105305Z","caller":"traceutil/trace.go:171","msg":"trace[55361542] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-68c9fdd89d-hp2g6.18c2395677fa362c; range_end:; response_count:1; response_revision:4878; }","duration":"160.121452ms","start":"2026-07-14T17:50:46.945129Z","end":"2026-07-14T17:50:47.10525Z","steps":["trace[55361542] 'agreement among raft nodes before linearized reading' (duration: 159.929927ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:50:47.645267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.413956ms","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-07-14T17:50:47.645409Z","caller":"traceutil/trace.go:171","msg":"trace[1479870230] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4892; }","duration":"115.560009ms","start":"2026-07-14T17:50:47.529788Z","end":"2026-07-14T17:50:47.645348Z","steps":["trace[1479870230] 'range keys from in-memory index tree' (duration: 115.142547ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:50:47.790688Z","caller":"traceutil/trace.go:171","msg":"trace[656038847] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"136.577941ms","start":"2026-07-14T17:50:47.65408Z","end":"2026-07-14T17:50:47.790658Z","steps":["trace[656038847] 'process raft request' (duration: 114.996714ms)","trace[656038847] 'compare' (duration: 21.358691ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:50:47.790794Z","caller":"traceutil/trace.go:171","msg":"trace[682856283] transaction","detail":"{read_only:false; response_revision:4895; number_of_response:1; }","duration":"136.615382ms","start":"2026-07-14T17:50:47.654125Z","end":"2026-07-14T17:50:47.790741Z","steps":["trace[682856283] 'process raft request' (duration: 136.462008ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:50:50.16485Z","caller":"traceutil/trace.go:171","msg":"trace[563861159] transaction","detail":"{read_only:false; response_revision:4920; number_of_response:1; }","duration":"146.822252ms","start":"2026-07-14T17:50:50.01801Z","end":"2026-07-14T17:50:50.164832Z","steps":["trace[563861159] 'process raft request' (duration: 146.704568ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T17:51:01.066256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.797916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T17:51:01.06637Z","caller":"traceutil/trace.go:171","msg":"trace[1625330596] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:5069; }","duration":"121.972231ms","start":"2026-07-14T17:51:00.944377Z","end":"2026-07-14T17:51:01.066349Z","steps":["trace[1625330596] 'count revisions from in-memory index tree' (duration: 121.705623ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:51:01.361895Z","caller":"traceutil/trace.go:171","msg":"trace[123068030] transaction","detail":"{read_only:false; response_revision:5075; number_of_response:1; }","duration":"104.935836ms","start":"2026-07-14T17:51:01.256928Z","end":"2026-07-14T17:51:01.361864Z","steps":["trace[123068030] 'process raft request' (duration: 11.010637ms)","trace[123068030] 'compare' (duration: 93.294332ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T17:51:37.599603Z","caller":"traceutil/trace.go:171","msg":"trace[860256066] transaction","detail":"{read_only:false; response_revision:5395; number_of_response:1; }","duration":"100.097318ms","start":"2026-07-14T17:51:37.499475Z","end":"2026-07-14T17:51:37.599572Z","steps":["trace[860256066] 'process raft request' (duration: 99.862361ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:51:37.617731Z","caller":"traceutil/trace.go:171","msg":"trace[1099864205] transaction","detail":"{read_only:false; response_revision:5396; number_of_response:1; }","duration":"103.652059ms","start":"2026-07-14T17:51:37.51405Z","end":"2026-07-14T17:51:37.617702Z","steps":["trace[1099864205] 'process raft request' (duration: 103.502365ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:51:37.618016Z","caller":"traceutil/trace.go:171","msg":"trace[1233910856] transaction","detail":"{read_only:false; response_revision:5397; number_of_response:1; }","duration":"103.226686ms","start":"2026-07-14T17:51:37.514777Z","end":"2026-07-14T17:51:37.618003Z","steps":["trace[1233910856] 'process raft request' (duration: 102.877896ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:51:56.918984Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2891} {"level":"info","ts":"2026-07-14T17:51:56.999709Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2891,"took":"79.513122ms","hash":2910196777,"current-db-size-bytes":52203520,"current-db-size":"52 MB","current-db-size-in-use-bytes":28905472,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-14T17:51:56.999778Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2910196777,"revision":2891,"compact-revision":-1} {"level":"info","ts":"2026-07-14T17:54:38.431775Z","caller":"traceutil/trace.go:171","msg":"trace[1594125311] transaction","detail":"{read_only:false; response_revision:6655; number_of_response:1; }","duration":"129.425163ms","start":"2026-07-14T17:54:38.302328Z","end":"2026-07-14T17:54:38.431753Z","steps":["trace[1594125311] 'process raft request' (duration: 129.291589ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T17:56:56.92741Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5550} {"level":"info","ts":"2026-07-14T17:56:57.028082Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5550,"took":"98.643674ms","hash":274314775,"current-db-size-bytes":52203520,"current-db-size":"52 MB","current-db-size-in-use-bytes":18485248,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-14T17:56:57.028152Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":274314775,"revision":5550,"compact-revision":2891}