{"level":"warn","ts":"2026-04-08T12:54:30.38333Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T12:54:30.383406Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223: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.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223: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-04-08T12:54:30.383541Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T12:54:30.383558Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-04-08T12:54:30.383575Z","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-04-08T12:54:30.384245Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]} {"level":"info","ts":"2026-04-08T12:54:30.384539Z","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.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223: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-04-08T12:54:30.387986Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.039167ms"} {"level":"info","ts":"2026-04-08T12:54:30.393727Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"} {"level":"info","ts":"2026-04-08T12:54:30.393879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T12:54:30.393908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"} {"level":"info","ts":"2026-04-08T12:54:30.393924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T12:54:30.393982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"} {"level":"info","ts":"2026-04-08T12:54:30.394079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"warn","ts":"2026-04-08T12:54:30.399567Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T12:54:30.40069Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T12:54:30.401913Z","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-04-08T12:54:30.403899Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T12:54:30.404105Z","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-04-08T12:54:30.404235Z","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-04-08T12:54:30.404253Z","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-04-08T12:54:30.404521Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T12:54:30.404889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"info","ts":"2026-04-08T12:54:30.405055Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-04-08T12:54:30.408469Z","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-04-08T12:54:30.408589Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-04-08T12:54:30.408638Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-04-08T12:54:30.4095Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T12:54:30.40955Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T12:54:31.294769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T12:54:31.294967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T12:54:31.295097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"} {"level":"info","ts":"2026-04-08T12:54:31.295197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"} {"level":"info","ts":"2026-04-08T12:54:31.295275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-04-08T12:54:31.295372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"} {"level":"info","ts":"2026-04-08T12:54:31.295489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-04-08T12:54:31.29642Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T12:54:31.29715Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T12:54:31.297152Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T12:54:31.297431Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T12:54:31.297933Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T12:54:31.298043Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T12:54:31.298076Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T12:54:31.298023Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T12:54:31.298568Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T12:54:31.299603Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T12:54:31.301483Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"} {"level":"warn","ts":"2026-04-08T12:54:37.258761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.472407ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T12:54:37.258918Z","caller":"traceutil/trace.go:171","msg":"trace[725936526] linearizableReadLoop","detail":"{readStateIndex:271; appliedIndex:270; }","duration":"300.660934ms","start":"2026-04-08T12:54:36.958236Z","end":"2026-04-08T12:54:37.258896Z","steps":["trace[725936526] 'read index received' (duration: 111.360008ms)","trace[725936526] 'applied index is now lower than readState.Index' (duration: 189.299386ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T12:54:37.258941Z","caller":"traceutil/trace.go:171","msg":"trace[385319130] transaction","detail":"{read_only:false; response_revision:263; number_of_response:1; }","duration":"384.259775ms","start":"2026-04-08T12:54:36.87465Z","end":"2026-04-08T12:54:37.25891Z","steps":["trace[385319130] 'process raft request' (duration: 195.03462ms)","trace[385319130] 'compare' (duration: 187.929152ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T12:54:37.259041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T12:54:36.874637Z","time spent":"384.357377ms","remote":"127.0.0.1:51886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":219,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T12:54:37.259294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.946866ms","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-04-08T12:54:37.259471Z","caller":"traceutil/trace.go:171","msg":"trace[272770373] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:263; }","duration":"309.110947ms","start":"2026-04-08T12:54:36.950267Z","end":"2026-04-08T12:54:37.259378Z","steps":["trace[272770373] 'agreement among raft nodes before linearized reading' (duration: 308.744643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T12:54:37.259549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T12:54:36.950254Z","time spent":"309.282819ms","remote":"127.0.0.1:51940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-08T12:54:37.320007Z","caller":"traceutil/trace.go:171","msg":"trace[299594806] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"358.376041ms","start":"2026-04-08T12:54:36.96161Z","end":"2026-04-08T12:54:37.319986Z","steps":["trace[299594806] 'process raft request' (duration: 358.171309ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:54:37.320029Z","caller":"traceutil/trace.go:171","msg":"trace[682681777] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"358.037678ms","start":"2026-04-08T12:54:36.96193Z","end":"2026-04-08T12:54:37.319968Z","steps":["trace[682681777] 'process raft request' (duration: 357.947367ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T12:54:37.320076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.76224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T12:54:37.320119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T12:54:36.961597Z","time spent":"358.461242ms","remote":"127.0.0.1:52012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T12:54:37.320171Z","caller":"traceutil/trace.go:171","msg":"trace[1925146901] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:265; }","duration":"323.890551ms","start":"2026-04-08T12:54:36.996265Z","end":"2026-04-08T12:54:37.320155Z","steps":["trace[1925146901] 'agreement among raft nodes before linearized reading' (duration: 323.731469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T12:54:37.320251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T12:54:36.996248Z","time spent":"323.993872ms","remote":"127.0.0.1:51652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-08T12:54:37.320442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T12:54:36.961921Z","time spent":"358.187049ms","remote":"127.0.0.1:51940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T12:54:37.45278Z","caller":"traceutil/trace.go:171","msg":"trace[274210366] linearizableReadLoop","detail":"{readStateIndex:274; appliedIndex:273; }","duration":"132.824952ms","start":"2026-04-08T12:54:37.319938Z","end":"2026-04-08T12:54:37.452763Z","steps":["trace[274210366] 'read index received' (duration: 100.969567ms)","trace[274210366] 'applied index is now lower than readState.Index' (duration: 31.854615ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T12:54:37.452855Z","caller":"traceutil/trace.go:171","msg":"trace[841835352] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"189.339727ms","start":"2026-04-08T12:54:37.263485Z","end":"2026-04-08T12:54:37.452825Z","steps":["trace[841835352] 'process raft request' (duration: 157.324629ms)","trace[841835352] 'compare' (duration: 31.882876ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T12:54:37.452947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.595149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T12:54:37.453027Z","caller":"traceutil/trace.go:171","msg":"trace[2120472868] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/persistent-volume-binder; range_end:; response_count:0; response_revision:266; }","duration":"188.705091ms","start":"2026-04-08T12:54:37.264301Z","end":"2026-04-08T12:54:37.453006Z","steps":["trace[2120472868] 'agreement among raft nodes before linearized reading' (duration: 188.553958ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:54:37.45353Z","caller":"traceutil/trace.go:171","msg":"trace[717729193] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"129.427507ms","start":"2026-04-08T12:54:37.324082Z","end":"2026-04-08T12:54:37.453509Z","steps":["trace[717729193] 'process raft request' (duration: 129.365286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T12:54:37.457636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.310801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T12:54:37.458292Z","caller":"traceutil/trace.go:171","msg":"trace[2136921803] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:267; }","duration":"136.975168ms","start":"2026-04-08T12:54:37.321283Z","end":"2026-04-08T12:54:37.458259Z","steps":["trace[2136921803] 'agreement among raft nodes before linearized reading' (duration: 136.312251ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:55:07.684964Z","caller":"traceutil/trace.go:171","msg":"trace[98731544] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"129.790125ms","start":"2026-04-08T12:55:07.55515Z","end":"2026-04-08T12:55:07.68494Z","steps":["trace[98731544] 'process raft request' (duration: 129.648944ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:55:07.691563Z","caller":"traceutil/trace.go:171","msg":"trace[517655445] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"126.386028ms","start":"2026-04-08T12:55:07.565148Z","end":"2026-04-08T12:55:07.691534Z","steps":["trace[517655445] 'process raft request' (duration: 126.221787ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:55:07.691902Z","caller":"traceutil/trace.go:171","msg":"trace[956881517] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"123.660078ms","start":"2026-04-08T12:55:07.568221Z","end":"2026-04-08T12:55:07.691881Z","steps":["trace[956881517] 'process raft request' (duration: 123.304835ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:55:07.69195Z","caller":"traceutil/trace.go:171","msg":"trace[1832174190] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"134.496662ms","start":"2026-04-08T12:55:07.557398Z","end":"2026-04-08T12:55:07.691895Z","steps":["trace[1832174190] 'process raft request' (duration: 133.818217ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:55:07.692163Z","caller":"traceutil/trace.go:171","msg":"trace[756727738] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"115.794286ms","start":"2026-04-08T12:55:07.576336Z","end":"2026-04-08T12:55:07.69213Z","steps":["trace[756727738] 'process raft request' (duration: 115.232922ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:55:07.692211Z","caller":"traceutil/trace.go:171","msg":"trace[1825732534] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"124.745645ms","start":"2026-04-08T12:55:07.567449Z","end":"2026-04-08T12:55:07.692195Z","steps":["trace[1825732534] 'process raft request' (duration: 123.957489ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:55:07.692408Z","caller":"traceutil/trace.go:171","msg":"trace[1103817935] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"124.935237ms","start":"2026-04-08T12:55:07.567462Z","end":"2026-04-08T12:55:07.692397Z","steps":["trace[1103817935] 'process raft request' (duration: 123.98266ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:55:07.692596Z","caller":"traceutil/trace.go:171","msg":"trace[642421996] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"125.038788ms","start":"2026-04-08T12:55:07.567544Z","end":"2026-04-08T12:55:07.692583Z","steps":["trace[642421996] 'process raft request' (duration: 123.94324ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:55:07.692829Z","caller":"traceutil/trace.go:171","msg":"trace[12653210] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"113.373697ms","start":"2026-04-08T12:55:07.579436Z","end":"2026-04-08T12:55:07.692809Z","steps":["trace[12653210] 'process raft request' (duration: 112.176348ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:55:07.693128Z","caller":"traceutil/trace.go:171","msg":"trace[1692662887] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"135.707591ms","start":"2026-04-08T12:55:07.557402Z","end":"2026-04-08T12:55:07.69311Z","steps":["trace[1692662887] 'process raft request' (duration: 133.930668ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:55:08.333157Z","caller":"traceutil/trace.go:171","msg":"trace[1991876931] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"105.220827ms","start":"2026-04-08T12:55:08.227909Z","end":"2026-04-08T12:55:08.33313Z","steps":["trace[1991876931] 'process raft request' (duration: 92.333597ms)","trace[1991876931] 'compare' (duration: 12.482767ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T12:55:13.622725Z","caller":"traceutil/trace.go:171","msg":"trace[1727581674] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"127.432865ms","start":"2026-04-08T12:55:13.495236Z","end":"2026-04-08T12:55:13.622669Z","steps":["trace[1727581674] 'process raft request' (duration: 127.130462ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:55:14.789032Z","caller":"traceutil/trace.go:171","msg":"trace[910578541] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:618; }","duration":"258.364183ms","start":"2026-04-08T12:55:14.530641Z","end":"2026-04-08T12:55:14.789005Z","steps":["trace[910578541] 'read index received' (duration: 257.90387ms)","trace[910578541] 'applied index is now lower than readState.Index' (duration: 459.533µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T12:55:14.789137Z","caller":"traceutil/trace.go:171","msg":"trace[822503460] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"435.631702ms","start":"2026-04-08T12:55:14.353491Z","end":"2026-04-08T12:55:14.789123Z","steps":["trace[822503460] 'process raft request' (duration: 435.35251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T12:55:14.789347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.879839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.223\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-08T12:55:14.789391Z","caller":"traceutil/trace.go:171","msg":"trace[1026976580] range","detail":"{range_begin:/registry/masterleases/199.204.45.223; range_end:; response_count:1; response_revision:600; }","duration":"238.96775ms","start":"2026-04-08T12:55:14.550412Z","end":"2026-04-08T12:55:14.78938Z","steps":["trace[1026976580] 'agreement among raft nodes before linearized reading' (duration: 238.862739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T12:55:14.789426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.676206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vkc7h\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-08T12:55:14.789623Z","caller":"traceutil/trace.go:171","msg":"trace[1287944717] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vkc7h; range_end:; response_count:1; response_revision:600; }","duration":"258.928547ms","start":"2026-04-08T12:55:14.530564Z","end":"2026-04-08T12:55:14.789493Z","steps":["trace[1287944717] 'agreement among raft nodes before linearized reading' (duration: 258.569634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T12:55:14.789907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T12:55:14.353469Z","time spent":"436.274138ms","remote":"127.0.0.1:51930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T12:55:40.060912Z","caller":"traceutil/trace.go:171","msg":"trace[361832113] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"120.912978ms","start":"2026-04-08T12:55:39.939979Z","end":"2026-04-08T12:55:40.060892Z","steps":["trace[361832113] 'process raft request' (duration: 120.794537ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:55:40.299178Z","caller":"traceutil/trace.go:171","msg":"trace[199611278] linearizableReadLoop","detail":"{readStateIndex:818; appliedIndex:816; }","duration":"301.684437ms","start":"2026-04-08T12:55:39.997454Z","end":"2026-04-08T12:55:40.299139Z","steps":["trace[199611278] 'read index received' (duration: 63.347758ms)","trace[199611278] 'applied index is now lower than readState.Index' (duration: 238.334679ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T12:55:40.299258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.781797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T12:55:40.299347Z","caller":"traceutil/trace.go:171","msg":"trace[1359271571] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:790; }","duration":"301.893058ms","start":"2026-04-08T12:55:39.997429Z","end":"2026-04-08T12:55:40.299322Z","steps":["trace[1359271571] 'agreement among raft nodes before linearized reading' (duration: 301.760447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T12:55:40.299387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T12:55:39.997414Z","time spent":"301.966108ms","remote":"127.0.0.1:51652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-08T12:55:40.299588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.657593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-08T12:55:40.299645Z","caller":"traceutil/trace.go:171","msg":"trace[1144077646] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:790; }","duration":"132.780274ms","start":"2026-04-08T12:55:40.166851Z","end":"2026-04-08T12:55:40.299631Z","steps":["trace[1144077646] 'agreement among raft nodes before linearized reading' (duration: 132.528682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T12:57:03.233955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.107823ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T12:57:03.234081Z","caller":"traceutil/trace.go:171","msg":"trace[1541296742] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"249.687992ms","start":"2026-04-08T12:57:02.984381Z","end":"2026-04-08T12:57:03.234069Z","steps":["trace[1541296742] 'process raft request' (duration: 249.653392ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:57:03.234134Z","caller":"traceutil/trace.go:171","msg":"trace[612445887] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"484.495071ms","start":"2026-04-08T12:57:02.749594Z","end":"2026-04-08T12:57:03.234089Z","steps":["trace[612445887] 'process raft request' (duration: 250.193465ms)","trace[612445887] 'compare' (duration: 234.023741ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T12:57:03.234123Z","caller":"traceutil/trace.go:171","msg":"trace[207303754] linearizableReadLoop","detail":"{readStateIndex:1955; appliedIndex:1953; }","duration":"431.708812ms","start":"2026-04-08T12:57:02.802395Z","end":"2026-04-08T12:57:03.234104Z","steps":["trace[207303754] 'read index received' (duration: 45.512743ms)","trace[207303754] 'applied index is now lower than readState.Index' (duration: 386.194199ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T12:57:03.234346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T12:57:02.749583Z","time spent":"484.670724ms","remote":"127.0.0.1:51940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T12:57:03.234466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.597998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7f26e370-55e7-420b-b10f-1d70520d4f2e\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-08T12:57:03.234493Z","caller":"traceutil/trace.go:171","msg":"trace[2074587143] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7f26e370-55e7-420b-b10f-1d70520d4f2e; range_end:; response_count:1; response_revision:1883; }","duration":"192.665289ms","start":"2026-04-08T12:57:03.04182Z","end":"2026-04-08T12:57:03.234486Z","steps":["trace[2074587143] 'agreement among raft nodes before linearized reading' (duration: 192.538327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T12:57:03.234501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.096888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-08T12:57:03.234652Z","caller":"traceutil/trace.go:171","msg":"trace[1913924409] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1883; }","duration":"432.228209ms","start":"2026-04-08T12:57:02.80236Z","end":"2026-04-08T12:57:03.234588Z","steps":["trace[1913924409] 'agreement among raft nodes before linearized reading' (duration: 431.835173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T12:57:03.234784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T12:57:02.802337Z","time spent":"432.415822ms","remote":"127.0.0.1:47484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5466,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-08T12:57:03.234648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.343857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T12:57:03.235089Z","caller":"traceutil/trace.go:171","msg":"trace[371256382] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1883; }","duration":"119.915175ms","start":"2026-04-08T12:57:03.115164Z","end":"2026-04-08T12:57:03.23508Z","steps":["trace[371256382] 'agreement among raft nodes before linearized reading' (duration: 119.297195ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:57:17.051447Z","caller":"traceutil/trace.go:171","msg":"trace[648721508] transaction","detail":"{read_only:false; response_revision:1996; number_of_response:1; }","duration":"142.603781ms","start":"2026-04-08T12:57:16.908824Z","end":"2026-04-08T12:57:17.051428Z","steps":["trace[648721508] 'process raft request' (duration: 134.372131ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:57:37.612533Z","caller":"traceutil/trace.go:171","msg":"trace[1416763623] linearizableReadLoop","detail":"{readStateIndex:2199; appliedIndex:2198; }","duration":"152.953443ms","start":"2026-04-08T12:57:37.459547Z","end":"2026-04-08T12:57:37.6125Z","steps":["trace[1416763623] 'read index received' (duration: 68.333476ms)","trace[1416763623] 'applied index is now lower than readState.Index' (duration: 84.618577ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T12:57:37.612843Z","caller":"traceutil/trace.go:171","msg":"trace[1977157220] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"170.460783ms","start":"2026-04-08T12:57:37.442338Z","end":"2026-04-08T12:57:37.612799Z","steps":["trace[1977157220] 'process raft request' (duration: 85.536662ms)","trace[1977157220] 'compare' (duration: 84.409985ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T12:57:37.612867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.298068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-08T12:57:37.612962Z","caller":"traceutil/trace.go:171","msg":"trace[1743019687] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2119; }","duration":"153.43191ms","start":"2026-04-08T12:57:37.459511Z","end":"2026-04-08T12:57:37.612943Z","steps":["trace[1743019687] 'agreement among raft nodes before linearized reading' (duration: 153.205397ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T12:57:37.613113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.33087ms","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-04-08T12:57:37.613196Z","caller":"traceutil/trace.go:171","msg":"trace[1683268315] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2119; }","duration":"144.441371ms","start":"2026-04-08T12:57:37.468741Z","end":"2026-04-08T12:57:37.613182Z","steps":["trace[1683268315] 'agreement among raft nodes before linearized reading' (duration: 144.221338ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:59:14.267815Z","caller":"traceutil/trace.go:171","msg":"trace[431220289] transaction","detail":"{read_only:false; response_revision:2748; number_of_response:1; }","duration":"187.945223ms","start":"2026-04-08T12:59:14.079845Z","end":"2026-04-08T12:59:14.26779Z","steps":["trace[431220289] 'process raft request' (duration: 187.778361ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:59:14.286426Z","caller":"traceutil/trace.go:171","msg":"trace[1605121346] transaction","detail":"{read_only:false; response_revision:2749; number_of_response:1; }","duration":"204.396356ms","start":"2026-04-08T12:59:14.082014Z","end":"2026-04-08T12:59:14.28641Z","steps":["trace[1605121346] 'process raft request' (duration: 204.276555ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T12:59:19.491823Z","caller":"traceutil/trace.go:171","msg":"trace[336263828] transaction","detail":"{read_only:false; response_revision:2779; number_of_response:1; }","duration":"122.121961ms","start":"2026-04-08T12:59:19.369671Z","end":"2026-04-08T12:59:19.491793Z","steps":["trace[336263828] 'process raft request' (duration: 121.869889ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:02:53.85681Z","caller":"traceutil/trace.go:171","msg":"trace[1167351188] transaction","detail":"{read_only:false; response_revision:4546; number_of_response:1; }","duration":"118.847516ms","start":"2026-04-08T13:02:53.73793Z","end":"2026-04-08T13:02:53.856778Z","steps":["trace[1167351188] 'process raft request' (duration: 118.662392ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:02:53.99671Z","caller":"traceutil/trace.go:171","msg":"trace[1293102443] linearizableReadLoop","detail":"{readStateIndex:4721; appliedIndex:4720; }","duration":"110.127103ms","start":"2026-04-08T13:02:53.886561Z","end":"2026-04-08T13:02:53.996688Z","steps":["trace[1293102443] 'read index received' (duration: 30.343874ms)","trace[1293102443] 'applied index is now lower than readState.Index' (duration: 79.782349ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T13:02:53.996844Z","caller":"traceutil/trace.go:171","msg":"trace[69213164] transaction","detail":"{read_only:false; response_revision:4547; number_of_response:1; }","duration":"120.052701ms","start":"2026-04-08T13:02:53.876731Z","end":"2026-04-08T13:02:53.996783Z","steps":["trace[69213164] 'process raft request' (duration: 40.199091ms)","trace[69213164] 'compare' (duration: 79.617175ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T13:02:53.997027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.45941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c8e800ea-be3c-4346-b97c-60af884cdbb9\" ","response":"range_response_count:1 size:4053"} {"level":"info","ts":"2026-04-08T13:02:53.997073Z","caller":"traceutil/trace.go:171","msg":"trace[269791439] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c8e800ea-be3c-4346-b97c-60af884cdbb9; range_end:; response_count:1; response_revision:4547; }","duration":"110.563052ms","start":"2026-04-08T13:02:53.886498Z","end":"2026-04-08T13:02:53.997061Z","steps":["trace[269791439] 'agreement among raft nodes before linearized reading' (duration: 110.354938ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:03:00.896323Z","caller":"traceutil/trace.go:171","msg":"trace[1688690417] linearizableReadLoop","detail":"{readStateIndex:4887; appliedIndex:4886; }","duration":"163.576054ms","start":"2026-04-08T13:03:00.732725Z","end":"2026-04-08T13:03:00.896301Z","steps":["trace[1688690417] 'read index received' (duration: 163.40132ms)","trace[1688690417] 'applied index is now lower than readState.Index' (duration: 173.894µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T13:03:00.896386Z","caller":"traceutil/trace.go:171","msg":"trace[235786288] transaction","detail":"{read_only:false; response_revision:4708; number_of_response:1; }","duration":"222.835121ms","start":"2026-04-08T13:03:00.673514Z","end":"2026-04-08T13:03:00.896349Z","steps":["trace[235786288] 'process raft request' (duration: 222.634317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:03:00.896624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.870499ms","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-04-08T13:03:00.896722Z","caller":"traceutil/trace.go:171","msg":"trace[2059510361] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4708; }","duration":"164.035942ms","start":"2026-04-08T13:03:00.732666Z","end":"2026-04-08T13:03:00.896702Z","steps":["trace[2059510361] 'agreement among raft nodes before linearized reading' (duration: 163.716266ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T13:03:00.897028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.292588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T13:03:00.897074Z","caller":"traceutil/trace.go:171","msg":"trace[944744825] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:4708; }","duration":"145.834089ms","start":"2026-04-08T13:03:00.75123Z","end":"2026-04-08T13:03:00.897064Z","steps":["trace[944744825] 'agreement among raft nodes before linearized reading' (duration: 145.303078ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:04:31.328303Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2841} {"level":"info","ts":"2026-04-08T13:04:31.396005Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2841,"took":"66.268681ms","hash":1467092678,"current-db-size-bytes":53870592,"current-db-size":"54 MB","current-db-size-in-use-bytes":28954624,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-08T13:04:31.396078Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1467092678,"revision":2841,"compact-revision":-1} {"level":"info","ts":"2026-04-08T13:06:55.849726Z","caller":"traceutil/trace.go:171","msg":"trace[472522718] transaction","detail":"{read_only:false; response_revision:6501; number_of_response:1; }","duration":"100.134894ms","start":"2026-04-08T13:06:55.749565Z","end":"2026-04-08T13:06:55.849699Z","steps":["trace[472522718] 'process raft request' (duration: 99.981482ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T13:09:31.361474Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5512} {"level":"info","ts":"2026-04-08T13:09:31.433417Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5512,"took":"71.002063ms","hash":667122313,"current-db-size-bytes":53870592,"current-db-size":"54 MB","current-db-size-in-use-bytes":18173952,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-08T13:09:31.433476Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":667122313,"revision":5512,"compact-revision":2841}