{"level":"warn","ts":"2026-04-15T08:56:38.954838Z","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-15T08:56:38.954942Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.162: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.162:2380","--initial-cluster=instance=https://199.204.45.162:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.162:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.162: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-15T08:56:38.955023Z","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-15T08:56:38.955103Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.162:2380"]}
{"level":"info","ts":"2026-04-15T08:56:38.955379Z","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-15T08:56:38.956218Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"]}
{"level":"info","ts":"2026-04-15T08:56:38.956316Z","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.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.162: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-15T08:56:38.959799Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.227385ms"}
{"level":"info","ts":"2026-04-15T08:56:38.966399Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2d372260bb4c37a","cluster-id":"52bb6ec15e8722ff"}
{"level":"info","ts":"2026-04-15T08:56:38.966471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=()"}
{"level":"info","ts":"2026-04-15T08:56:38.966502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 0"}
{"level":"info","ts":"2026-04-15T08:56:38.966514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2d372260bb4c37a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-15T08:56:38.966521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 1"}
{"level":"info","ts":"2026-04-15T08:56:38.966556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"}
{"level":"warn","ts":"2026-04-15T08:56:38.97405Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-15T08:56:38.975477Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-15T08:56:38.976624Z","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-15T08:56:38.979349Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2d372260bb4c37a","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-15T08:56:38.98197Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2d372260bb4c37a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-15T08:56:38.982141Z","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-15T08:56:38.982429Z","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-15T08:56:38.982526Z","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-15T08:56:38.986024Z","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-15T08:56:38.986303Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2d372260bb4c37a","initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-15T08:56:38.986335Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-15T08:56:38.986479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"}
{"level":"info","ts":"2026-04-15T08:56:38.986631Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","added-peer-id":"2d372260bb4c37a","added-peer-peer-urls":["https://199.204.45.162:2380"]}
{"level":"info","ts":"2026-04-15T08:56:38.986703Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.162:2380"}
{"level":"info","ts":"2026-04-15T08:56:38.986714Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.162:2380"}
{"level":"info","ts":"2026-04-15T08:56:39.86726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a is starting a new election at term 1"}
{"level":"info","ts":"2026-04-15T08:56:39.867326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-15T08:56:39.867346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgPreVoteResp from 2d372260bb4c37a at term 1"}
{"level":"info","ts":"2026-04-15T08:56:39.86736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became candidate at term 2"}
{"level":"info","ts":"2026-04-15T08:56:39.867374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgVoteResp from 2d372260bb4c37a at term 2"}
{"level":"info","ts":"2026-04-15T08:56:39.867389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became leader at term 2"}
{"level":"info","ts":"2026-04-15T08:56:39.867399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2d372260bb4c37a elected leader 2d372260bb4c37a at term 2"}
{"level":"info","ts":"2026-04-15T08:56:39.868824Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2d372260bb4c37a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.162:2379]}","request-path":"/0/members/2d372260bb4c37a/attributes","cluster-id":"52bb6ec15e8722ff","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-15T08:56:39.869263Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-15T08:56:39.869609Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-15T08:56:39.869683Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-15T08:56:39.869725Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-15T08:56:39.869684Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-15T08:56:39.872291Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.162:2379"}
{"level":"info","ts":"2026-04-15T08:56:39.873168Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-15T08:56:39.873313Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-15T08:56:39.873361Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-15T08:56:39.87663Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-04-15T08:56:42.033168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.830749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-04-15T08:56:42.033427Z","caller":"traceutil/trace.go:171","msg":"trace[312781255] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:115; }","duration":"164.156761ms","start":"2026-04-15T08:56:41.869241Z","end":"2026-04-15T08:56:42.033398Z","steps":["trace[312781255] 'range keys from in-memory index tree'  (duration: 163.750269ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T08:57:16.578851Z","caller":"traceutil/trace.go:171","msg":"trace[1421316475] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"105.006305ms","start":"2026-04-15T08:57:16.473811Z","end":"2026-04-15T08:57:16.578817Z","steps":["trace[1421316475] 'process raft request'  (duration: 104.875925ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-15T08:57:32.079141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.468277ms","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-15T08:57:32.079254Z","caller":"traceutil/trace.go:171","msg":"trace[1717642078] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:795; }","duration":"169.651778ms","start":"2026-04-15T08:57:31.909578Z","end":"2026-04-15T08:57:32.079229Z","steps":["trace[1717642078] 'range keys from in-memory index tree'  (duration: 169.164267ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T08:58:00.488817Z","caller":"traceutil/trace.go:171","msg":"trace[792927581] linearizableReadLoop","detail":"{readStateIndex:1222; appliedIndex:1221; }","duration":"217.973904ms","start":"2026-04-15T08:58:00.270808Z","end":"2026-04-15T08:58:00.488782Z","steps":["trace[792927581] 'read index received'  (duration: 217.798919ms)","trace[792927581] 'applied index is now lower than readState.Index'  (duration: 173.405µs)"],"step_count":2}
{"level":"info","ts":"2026-04-15T08:58:00.489069Z","caller":"traceutil/trace.go:171","msg":"trace[1809570184] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"228.650765ms","start":"2026-04-15T08:58:00.260377Z","end":"2026-04-15T08:58:00.489028Z","steps":["trace[1809570184] 'process raft request'  (duration: 228.18593ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-15T08:58:00.49027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.354619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-15T08:58:00.490588Z","caller":"traceutil/trace.go:171","msg":"trace[1565715912] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1189; }","duration":"219.791743ms","start":"2026-04-15T08:58:00.270749Z","end":"2026-04-15T08:58:00.490541Z","steps":["trace[1565715912] 'agreement among raft nodes before linearized reading'  (duration: 218.176631ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-15T08:58:23.014506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.475186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-15T08:58:23.014581Z","caller":"traceutil/trace.go:171","msg":"trace[822412400] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1449; }","duration":"106.613809ms","start":"2026-04-15T08:58:22.907953Z","end":"2026-04-15T08:58:23.014567Z","steps":["trace[822412400] 'count revisions from in-memory index tree'  (duration: 106.375834ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-15T08:58:48.927973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.811752ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085744027888075979 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:1760 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-15T08:58:48.928203Z","caller":"traceutil/trace.go:171","msg":"trace[1879399725] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"312.136832ms","start":"2026-04-15T08:58:48.616051Z","end":"2026-04-15T08:58:48.928188Z","steps":["trace[1879399725] 'process raft request'  (duration: 47.574375ms)","trace[1879399725] 'compare'  (duration: 263.661389ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-15T08:58:48.928263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T08:58:48.616024Z","time spent":"312.211624ms","remote":"127.0.0.1:54834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:1760 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-04-15T08:58:48.938512Z","caller":"traceutil/trace.go:171","msg":"trace[1928039628] linearizableReadLoop","detail":"{readStateIndex:1942; appliedIndex:1941; }","duration":"195.861256ms","start":"2026-04-15T08:58:48.742627Z","end":"2026-04-15T08:58:48.938489Z","steps":["trace[1928039628] 'read index received'  (duration: 195.718913ms)","trace[1928039628] 'applied index is now lower than readState.Index'  (duration: 141.153µs)"],"step_count":2}
{"level":"info","ts":"2026-04-15T08:58:48.938562Z","caller":"traceutil/trace.go:171","msg":"trace[518572977] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"240.024845ms","start":"2026-04-15T08:58:48.698512Z","end":"2026-04-15T08:58:48.938537Z","steps":["trace[518572977] 'process raft request'  (duration: 239.857031ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-15T08:58:48.938779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.155502ms","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-15T08:58:48.938847Z","caller":"traceutil/trace.go:171","msg":"trace[578280448] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1874; }","duration":"196.267254ms","start":"2026-04-15T08:58:48.742564Z","end":"2026-04-15T08:58:48.938831Z","steps":["trace[578280448] 'agreement among raft nodes before linearized reading'  (duration: 196.05676ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-15T08:58:48.938946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.673659ms","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-04-15T08:58:48.939036Z","caller":"traceutil/trace.go:171","msg":"trace[1687837953] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1874; }","duration":"160.765341ms","start":"2026-04-15T08:58:48.778233Z","end":"2026-04-15T08:58:48.938998Z","steps":["trace[1687837953] 'agreement among raft nodes before linearized reading'  (duration: 160.605518ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-15T08:58:48.939528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.894855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6c73459a-eef4-414e-b623-79fc625eb028\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-04-15T08:58:48.939627Z","caller":"traceutil/trace.go:171","msg":"trace[1823163767] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6c73459a-eef4-414e-b623-79fc625eb028; range_end:; response_count:1; response_revision:1874; }","duration":"172.039869ms","start":"2026-04-15T08:58:48.767563Z","end":"2026-04-15T08:58:48.939603Z","steps":["trace[1823163767] 'agreement among raft nodes before linearized reading'  (duration: 171.12036ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T08:58:49.101377Z","caller":"traceutil/trace.go:171","msg":"trace[1076380809] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"101.945842ms","start":"2026-04-15T08:58:48.999402Z","end":"2026-04-15T08:58:49.101348Z","steps":["trace[1076380809] 'process raft request'  (duration: 93.304677ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T08:59:02.018075Z","caller":"traceutil/trace.go:171","msg":"trace[111877461] transaction","detail":"{read_only:false; response_revision:1981; number_of_response:1; }","duration":"198.376575ms","start":"2026-04-15T08:59:01.819671Z","end":"2026-04-15T08:59:02.018048Z","steps":["trace[111877461] 'process raft request'  (duration: 198.104411ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-15T08:59:28.421494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.983943ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085744027888076578 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:2130 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-15T08:59:28.421808Z","caller":"traceutil/trace.go:171","msg":"trace[279559595] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"237.66894ms","start":"2026-04-15T08:59:28.184094Z","end":"2026-04-15T08:59:28.421763Z","steps":["trace[279559595] 'process raft request'  (duration: 124.263ms)","trace[279559595] 'compare'  (duration: 112.661349ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-15T08:59:28.570767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.111616ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085744027888076579 > lease_revoke:<id:437a9d905b594649>","response":"size:27"}
{"level":"info","ts":"2026-04-15T08:59:28.571406Z","caller":"traceutil/trace.go:171","msg":"trace[1043789053] linearizableReadLoop","detail":"{readStateIndex:2219; appliedIndex:2216; }","duration":"336.969733ms","start":"2026-04-15T08:59:28.234401Z","end":"2026-04-15T08:59:28.571371Z","steps":["trace[1043789053] 'read index received'  (duration: 74.040001ms)","trace[1043789053] 'applied index is now lower than readState.Index'  (duration: 262.928182ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-15T08:59:28.571646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.231237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-15T08:59:28.571712Z","caller":"traceutil/trace.go:171","msg":"trace[1091548668] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2143; }","duration":"337.334007ms","start":"2026-04-15T08:59:28.234358Z","end":"2026-04-15T08:59:28.571692Z","steps":["trace[1091548668] 'agreement among raft nodes before linearized reading'  (duration: 337.231636ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-15T08:59:28.571762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T08:59:28.234339Z","time spent":"337.415298ms","remote":"127.0.0.1:54538","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-15T08:59:28.571849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.739826ms","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-04-15T08:59:28.571905Z","caller":"traceutil/trace.go:171","msg":"trace[1741325935] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2143; }","duration":"297.826587ms","start":"2026-04-15T08:59:28.274061Z","end":"2026-04-15T08:59:28.571888Z","steps":["trace[1741325935] 'agreement among raft nodes before linearized reading'  (duration: 297.624324ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T08:59:28.571975Z","caller":"traceutil/trace.go:171","msg":"trace[620417838] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"363.564803ms","start":"2026-04-15T08:59:28.208396Z","end":"2026-04-15T08:59:28.571961Z","steps":["trace[620417838] 'process raft request'  (duration: 362.490118ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-15T08:59:28.57208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T08:59:28.208363Z","time spent":"363.648225ms","remote":"127.0.0.1:54834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2131 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-04-15T08:59:29.416707Z","caller":"traceutil/trace.go:171","msg":"trace[642366053] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"176.279728ms","start":"2026-04-15T08:59:29.240399Z","end":"2026-04-15T08:59:29.416679Z","steps":["trace[642366053] 'process raft request'  (duration: 176.133596ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-15T08:59:29.596917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.694854ms","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-04-15T08:59:29.597018Z","caller":"traceutil/trace.go:171","msg":"trace[634048000] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:2145; }","duration":"103.865516ms","start":"2026-04-15T08:59:29.493131Z","end":"2026-04-15T08:59:29.596996Z","steps":["trace[634048000] 'count revisions from in-memory index tree'  (duration: 103.556962ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T08:59:30.052296Z","caller":"traceutil/trace.go:171","msg":"trace[1286997222] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"175.084758ms","start":"2026-04-15T08:59:29.877166Z","end":"2026-04-15T08:59:30.05225Z","steps":["trace[1286997222] 'process raft request'  (duration: 155.775462ms)","trace[1286997222] 'compare'  (duration: 19.063852ms)"],"step_count":2}
{"level":"info","ts":"2026-04-15T09:00:23.818843Z","caller":"traceutil/trace.go:171","msg":"trace[1881563453] transaction","detail":"{read_only:false; response_revision:2529; number_of_response:1; }","duration":"139.560785ms","start":"2026-04-15T09:00:23.679266Z","end":"2026-04-15T09:00:23.818827Z","steps":["trace[1881563453] 'process raft request'  (duration: 139.461634ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-15T09:00:58.448207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.560065ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14085744027888078021 > lease_revoke:<id:437a9d905b594be2>","response":"size:27"}
{"level":"warn","ts":"2026-04-15T09:00:58.781105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.370901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-15T09:00:58.781245Z","caller":"traceutil/trace.go:171","msg":"trace[1819390878] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2737; }","duration":"157.545042ms","start":"2026-04-15T09:00:58.623676Z","end":"2026-04-15T09:00:58.781221Z","steps":["trace[1819390878] 'range keys from in-memory index tree'  (duration: 157.201739ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-15T09:00:58.781355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.689184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-15T09:00:58.781449Z","caller":"traceutil/trace.go:171","msg":"trace[238127068] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2737; }","duration":"157.818875ms","start":"2026-04-15T09:00:58.623603Z","end":"2026-04-15T09:00:58.781421Z","steps":["trace[238127068] 'range keys from in-memory index tree'  (duration: 157.457062ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T09:00:58.918317Z","caller":"traceutil/trace.go:171","msg":"trace[1790666593] transaction","detail":"{read_only:false; response_revision:2738; number_of_response:1; }","duration":"131.787822ms","start":"2026-04-15T09:00:58.786497Z","end":"2026-04-15T09:00:58.918285Z","steps":["trace[1790666593] 'process raft request'  (duration: 131.61243ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T09:00:58.985246Z","caller":"traceutil/trace.go:171","msg":"trace[852076071] linearizableReadLoop","detail":"{readStateIndex:2836; appliedIndex:2835; }","duration":"126.518392ms","start":"2026-04-15T09:00:58.858698Z","end":"2026-04-15T09:00:58.985216Z","steps":["trace[852076071] 'read index received'  (duration: 59.859459ms)","trace[852076071] 'applied index is now lower than readState.Index'  (duration: 66.657583ms)"],"step_count":2}
{"level":"info","ts":"2026-04-15T09:00:58.985279Z","caller":"traceutil/trace.go:171","msg":"trace[1887972793] transaction","detail":"{read_only:false; response_revision:2739; number_of_response:1; }","duration":"198.477136ms","start":"2026-04-15T09:00:58.786765Z","end":"2026-04-15T09:00:58.985242Z","steps":["trace[1887972793] 'process raft request'  (duration: 196.208694ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T09:00:58.985338Z","caller":"traceutil/trace.go:171","msg":"trace[1103534463] transaction","detail":"{read_only:false; response_revision:2740; number_of_response:1; }","duration":"105.838709ms","start":"2026-04-15T09:00:58.879467Z","end":"2026-04-15T09:00:58.985305Z","steps":["trace[1103534463] 'process raft request'  (duration: 105.666938ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-15T09:00:58.985757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.028887ms","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-15T09:00:58.985816Z","caller":"traceutil/trace.go:171","msg":"trace[1336451530] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2740; }","duration":"127.175569ms","start":"2026-04-15T09:00:58.858628Z","end":"2026-04-15T09:00:58.985803Z","steps":["trace[1336451530] 'agreement among raft nodes before linearized reading'  (duration: 126.761105ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T09:04:35.099301Z","caller":"traceutil/trace.go:171","msg":"trace[1883268744] transaction","detail":"{read_only:false; response_revision:4411; number_of_response:1; }","duration":"115.532446ms","start":"2026-04-15T09:04:34.983735Z","end":"2026-04-15T09:04:35.099267Z","steps":["trace[1883268744] 'process raft request'  (duration: 73.964844ms)","trace[1883268744] 'compare'  (duration: 41.305788ms)"],"step_count":2}
{"level":"info","ts":"2026-04-15T09:04:45.99361Z","caller":"traceutil/trace.go:171","msg":"trace[2068035896] transaction","detail":"{read_only:false; response_revision:4701; number_of_response:1; }","duration":"209.259598ms","start":"2026-04-15T09:04:45.784308Z","end":"2026-04-15T09:04:45.993568Z","steps":["trace[2068035896] 'process raft request'  (duration: 209.184207ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T09:04:45.993609Z","caller":"traceutil/trace.go:171","msg":"trace[1731819505] transaction","detail":"{read_only:false; response_revision:4700; number_of_response:1; }","duration":"211.19505ms","start":"2026-04-15T09:04:45.782377Z","end":"2026-04-15T09:04:45.993572Z","steps":["trace[1731819505] 'process raft request'  (duration: 182.575988ms)","trace[1731819505] 'compare'  (duration: 28.323107ms)"],"step_count":2}
{"level":"info","ts":"2026-04-15T09:04:45.993735Z","caller":"traceutil/trace.go:171","msg":"trace[16066139] linearizableReadLoop","detail":"{readStateIndex:4871; appliedIndex:4869; }","duration":"211.263931ms","start":"2026-04-15T09:04:45.782452Z","end":"2026-04-15T09:04:45.993716Z","steps":["trace[16066139] 'read index received'  (duration: 26.128069ms)","trace[16066139] 'applied index is now lower than readState.Index'  (duration: 185.134592ms)"],"step_count":2}
{"level":"info","ts":"2026-04-15T09:04:45.993797Z","caller":"traceutil/trace.go:171","msg":"trace[1150036689] transaction","detail":"{read_only:false; response_revision:4702; number_of_response:1; }","duration":"209.424191ms","start":"2026-04-15T09:04:45.784362Z","end":"2026-04-15T09:04:45.993786Z","steps":["trace[1150036689] 'process raft request'  (duration: 209.172987ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-15T09:04:45.99391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.429293ms","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-04-15T09:04:45.993942Z","caller":"traceutil/trace.go:171","msg":"trace[1534530565] 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:4702; }","duration":"211.523085ms","start":"2026-04-15T09:04:45.782408Z","end":"2026-04-15T09:04:45.993932Z","steps":["trace[1534530565] 'agreement among raft nodes before linearized reading'  (duration: 211.394753ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T09:04:46.149494Z","caller":"traceutil/trace.go:171","msg":"trace[1030398349] linearizableReadLoop","detail":"{readStateIndex:4875; appliedIndex:4873; }","duration":"155.656997ms","start":"2026-04-15T09:04:45.993782Z","end":"2026-04-15T09:04:46.149439Z","steps":["trace[1030398349] 'read index received'  (duration: 138.885895ms)","trace[1030398349] 'applied index is now lower than readState.Index'  (duration: 16.770302ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-15T09:04:46.149683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.763232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-15T09:04:46.149749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.252757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-0aaac574-13e0-4300-a2c6-e7833497b383\" ","response":"range_response_count:1 size:1450"}
{"level":"info","ts":"2026-04-15T09:04:46.149762Z","caller":"traceutil/trace.go:171","msg":"trace[324985757] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4704; }","duration":"307.890833ms","start":"2026-04-15T09:04:45.841852Z","end":"2026-04-15T09:04:46.149743Z","steps":["trace[324985757] 'agreement among raft nodes before linearized reading'  (duration: 307.732771ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T09:04:46.149781Z","caller":"traceutil/trace.go:171","msg":"trace[95159605] range","detail":"{range_begin:/registry/persistentvolumes/pvc-0aaac574-13e0-4300-a2c6-e7833497b383; range_end:; response_count:1; response_revision:4704; }","duration":"153.339729ms","start":"2026-04-15T09:04:45.996431Z","end":"2026-04-15T09:04:46.149771Z","steps":["trace[95159605] 'agreement among raft nodes before linearized reading'  (duration: 153.184646ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-15T09:04:46.149776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.219413ms","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-04-15T09:04:46.149867Z","caller":"traceutil/trace.go:171","msg":"trace[563317607] transaction","detail":"{read_only:false; response_revision:4704; number_of_response:1; }","duration":"268.726043ms","start":"2026-04-15T09:04:45.881126Z","end":"2026-04-15T09:04:46.149852Z","steps":["trace[563317607] 'process raft request'  (duration: 268.257765ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T09:04:46.149903Z","caller":"traceutil/trace.go:171","msg":"trace[1743238893] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4704; }","duration":"345.408355ms","start":"2026-04-15T09:04:45.804463Z","end":"2026-04-15T09:04:46.149871Z","steps":["trace[1743238893] 'agreement among raft nodes before linearized reading'  (duration: 345.153381ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-15T09:04:46.149976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T09:04:45.804445Z","time spent":"345.521088ms","remote":"127.0.0.1:55030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"info","ts":"2026-04-15T09:04:46.150007Z","caller":"traceutil/trace.go:171","msg":"trace[1143570429] transaction","detail":"{read_only:false; response_revision:4703; number_of_response:1; }","duration":"322.343707ms","start":"2026-04-15T09:04:45.827624Z","end":"2026-04-15T09:04:46.149968Z","steps":["trace[1143570429] 'process raft request'  (duration: 305.059877ms)","trace[1143570429] 'compare'  (duration: 16.598789ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-15T09:04:46.150165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T09:04:45.827608Z","time spent":"322.475539ms","remote":"127.0.0.1:54834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4622 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-04-15T09:04:46.149818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T09:04:45.841831Z","time spent":"307.973205ms","remote":"127.0.0.1:54538","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-15T09:04:46.1513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.160192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2193165"}
{"level":"info","ts":"2026-04-15T09:04:46.151384Z","caller":"traceutil/trace.go:171","msg":"trace[1136867936] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4704; }","duration":"154.254894ms","start":"2026-04-15T09:04:45.997095Z","end":"2026-04-15T09:04:46.15135Z","steps":["trace[1136867936] 'agreement among raft nodes before linearized reading'  (duration: 153.242097ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T09:04:59.940152Z","caller":"traceutil/trace.go:171","msg":"trace[71756493] transaction","detail":"{read_only:false; response_revision:4882; number_of_response:1; }","duration":"332.132556ms","start":"2026-04-15T09:04:59.608001Z","end":"2026-04-15T09:04:59.940133Z","steps":["trace[71756493] 'process raft request'  (duration: 331.904922ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-15T09:04:59.940278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T09:04:59.607974Z","time spent":"332.236788ms","remote":"127.0.0.1:54834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:4854 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-04-15T09:05:00.198992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.470281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-0aaac574-13e0-4300-a2c6-e7833497b383\" ","response":"range_response_count:1 size:1450"}
{"level":"info","ts":"2026-04-15T09:05:00.199109Z","caller":"traceutil/trace.go:171","msg":"trace[346635244] range","detail":"{range_begin:/registry/persistentvolumes/pvc-0aaac574-13e0-4300-a2c6-e7833497b383; range_end:; response_count:1; response_revision:4882; }","duration":"248.648944ms","start":"2026-04-15T09:04:59.950427Z","end":"2026-04-15T09:05:00.199076Z","steps":["trace[346635244] 'range keys from in-memory index tree'  (duration: 248.214086ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T09:05:00.200464Z","caller":"traceutil/trace.go:171","msg":"trace[2027903234] transaction","detail":"{read_only:false; response_revision:4883; number_of_response:1; }","duration":"249.722301ms","start":"2026-04-15T09:04:59.950721Z","end":"2026-04-15T09:05:00.200444Z","steps":["trace[2027903234] 'process raft request'  (duration: 248.013693ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T09:06:39.900065Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2954}
{"level":"info","ts":"2026-04-15T09:06:39.995079Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2954,"took":"93.348943ms","hash":2248811495,"current-db-size-bytes":53047296,"current-db-size":"53 MB","current-db-size-in-use-bytes":29630464,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-04-15T09:06:39.995156Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2248811495,"revision":2954,"compact-revision":-1}
{"level":"info","ts":"2026-04-15T09:08:53.700016Z","caller":"traceutil/trace.go:171","msg":"trace[811635530] transaction","detail":"{read_only:false; response_revision:6611; number_of_response:1; }","duration":"100.504274ms","start":"2026-04-15T09:08:53.599476Z","end":"2026-04-15T09:08:53.69998Z","steps":["trace[811635530] 'process raft request'  (duration: 92.727414ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T09:08:53.724748Z","caller":"traceutil/trace.go:171","msg":"trace[2026751503] transaction","detail":"{read_only:false; response_revision:6613; number_of_response:1; }","duration":"124.975098ms","start":"2026-04-15T09:08:53.599741Z","end":"2026-04-15T09:08:53.724716Z","steps":["trace[2026751503] 'process raft request'  (duration: 124.910267ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T09:08:53.724947Z","caller":"traceutil/trace.go:171","msg":"trace[1486117171] transaction","detail":"{read_only:false; response_revision:6612; number_of_response:1; }","duration":"125.23936ms","start":"2026-04-15T09:08:53.599667Z","end":"2026-04-15T09:08:53.724907Z","steps":["trace[1486117171] 'process raft request'  (duration: 124.806735ms)"],"step_count":1}
{"level":"info","ts":"2026-04-15T09:11:39.905553Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5675}
{"level":"info","ts":"2026-04-15T09:11:39.985796Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5675,"took":"78.692903ms","hash":2702486805,"current-db-size-bytes":53047296,"current-db-size":"53 MB","current-db-size-in-use-bytes":18337792,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-04-15T09:11:39.985861Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2702486805,"revision":5675,"compact-revision":2954}