{"level":"warn","ts":"2026-08-24T15:13:55.550295Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-24T15:13:55.550393Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.200: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.200:2380","--initial-cluster=instance=https://199.19.213.200:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.200:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.200: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-08-24T15:13:55.550461Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-24T15:13:55.550473Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.200:2380"]} {"level":"info","ts":"2026-08-24T15:13:55.550509Z","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-08-24T15:13:55.551134Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.200:2379"]} {"level":"info","ts":"2026-08-24T15:13:55.551226Z","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.200:2380"],"listen-peer-urls":["https://199.19.213.200:2380"],"advertise-client-urls":["https://199.19.213.200:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.200:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.200: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-08-24T15:13:55.55608Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.642124ms"} {"level":"info","ts":"2026-08-24T15:13:55.564702Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3363378c2227fa42","cluster-id":"7faf957b2e4cf761"} {"level":"info","ts":"2026-08-24T15:13:55.564777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 switched to configuration voters=()"} {"level":"info","ts":"2026-08-24T15:13:55.564798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 became follower at term 0"} {"level":"info","ts":"2026-08-24T15:13:55.564808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3363378c2227fa42 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-24T15:13:55.564819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 became follower at term 1"} {"level":"info","ts":"2026-08-24T15:13:55.564857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 switched to configuration voters=(3702864393636674114)"} {"level":"warn","ts":"2026-08-24T15:13:55.572217Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-24T15:13:55.57364Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-24T15:13:55.57567Z","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-08-24T15:13:55.579347Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3363378c2227fa42","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-24T15:13:55.579668Z","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-08-24T15:13:55.579829Z","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-08-24T15:13:55.579859Z","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-08-24T15:13:55.579855Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3363378c2227fa42","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-24T15:13:55.581138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 switched to configuration voters=(3702864393636674114)"} {"level":"info","ts":"2026-08-24T15:13:55.587244Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7faf957b2e4cf761","local-member-id":"3363378c2227fa42","added-peer-id":"3363378c2227fa42","added-peer-peer-urls":["https://199.19.213.200:2380"]} {"level":"info","ts":"2026-08-24T15:13:55.588861Z","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-08-24T15:13:55.589038Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.200:2380"} {"level":"info","ts":"2026-08-24T15:13:55.589099Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.200:2380"} {"level":"info","ts":"2026-08-24T15:13:55.589102Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3363378c2227fa42","initial-advertise-peer-urls":["https://199.19.213.200:2380"],"listen-peer-urls":["https://199.19.213.200:2380"],"advertise-client-urls":["https://199.19.213.200:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.200:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-24T15:13:55.589166Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-24T15:13:56.465568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 is starting a new election at term 1"} {"level":"info","ts":"2026-08-24T15:13:56.465626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-24T15:13:56.465675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 received MsgPreVoteResp from 3363378c2227fa42 at term 1"} {"level":"info","ts":"2026-08-24T15:13:56.465703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 became candidate at term 2"} {"level":"info","ts":"2026-08-24T15:13:56.465719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 received MsgVoteResp from 3363378c2227fa42 at term 2"} {"level":"info","ts":"2026-08-24T15:13:56.465739Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3363378c2227fa42 became leader at term 2"} {"level":"info","ts":"2026-08-24T15:13:56.465752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3363378c2227fa42 elected leader 3363378c2227fa42 at term 2"} {"level":"info","ts":"2026-08-24T15:13:56.466817Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:13:56.467635Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-24T15:13:56.467635Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3363378c2227fa42","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.200:2379]}","request-path":"/0/members/3363378c2227fa42/attributes","cluster-id":"7faf957b2e4cf761","publish-timeout":"7s"} {"level":"info","ts":"2026-08-24T15:13:56.467694Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-24T15:13:56.468357Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7faf957b2e4cf761","local-member-id":"3363378c2227fa42","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:13:56.468482Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:13:56.468519Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-24T15:13:56.471441Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-24T15:13:56.471763Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.200:2379"} {"level":"info","ts":"2026-08-24T15:13:56.475609Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-24T15:13:56.47566Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-24T15:14:15.149963Z","caller":"traceutil/trace.go:171","msg":"trace[1748729932] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"182.177588ms","start":"2026-08-24T15:14:14.96777Z","end":"2026-08-24T15:14:15.149947Z","steps":["trace[1748729932] 'process raft request' (duration: 181.813118ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:15.573718Z","caller":"traceutil/trace.go:171","msg":"trace[1885421183] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"420.100327ms","start":"2026-08-24T15:14:15.153584Z","end":"2026-08-24T15:14:15.573684Z","steps":["trace[1885421183] 'process raft request' (duration: 419.936223ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:15.574433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:14:15.153573Z","time spent":"420.22575ms","remote":"127.0.0.1:42586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:14:35.316623Z","caller":"traceutil/trace.go:171","msg":"trace[1756456427] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"152.680353ms","start":"2026-08-24T15:14:35.163923Z","end":"2026-08-24T15:14:35.316603Z","steps":["trace[1756456427] 'process raft request' (duration: 152.56928ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:35.324671Z","caller":"traceutil/trace.go:171","msg":"trace[1932213956] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"160.34974ms","start":"2026-08-24T15:14:35.164297Z","end":"2026-08-24T15:14:35.324647Z","steps":["trace[1932213956] 'process raft request' (duration: 158.033771ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:35.325358Z","caller":"traceutil/trace.go:171","msg":"trace[1411272591] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"119.606781ms","start":"2026-08-24T15:14:35.205726Z","end":"2026-08-24T15:14:35.325332Z","steps":["trace[1411272591] 'process raft request' (duration: 117.369153ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:35.32541Z","caller":"traceutil/trace.go:171","msg":"trace[1190375331] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"144.711658ms","start":"2026-08-24T15:14:35.180692Z","end":"2026-08-24T15:14:35.325403Z","steps":["trace[1190375331] 'process raft request' (duration: 141.880645ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:35.325486Z","caller":"traceutil/trace.go:171","msg":"trace[815696356] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"137.8271ms","start":"2026-08-24T15:14:35.187653Z","end":"2026-08-24T15:14:35.32548Z","steps":["trace[815696356] 'process raft request' (duration: 134.992197ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:35.325629Z","caller":"traceutil/trace.go:171","msg":"trace[782594547] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"133.817457ms","start":"2026-08-24T15:14:35.191671Z","end":"2026-08-24T15:14:35.325488Z","steps":["trace[782594547] 'process raft request' (duration: 131.22835ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:35.325675Z","caller":"traceutil/trace.go:171","msg":"trace[702876059] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"104.943853ms","start":"2026-08-24T15:14:35.220723Z","end":"2026-08-24T15:14:35.325667Z","steps":["trace[702876059] 'process raft request' (duration: 102.474079ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:35.325732Z","caller":"traceutil/trace.go:171","msg":"trace[1717416704] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"103.882386ms","start":"2026-08-24T15:14:35.221844Z","end":"2026-08-24T15:14:35.325726Z","steps":["trace[1717416704] 'process raft request' (duration: 101.445713ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:35.325373Z","caller":"traceutil/trace.go:171","msg":"trace[1482868114] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"133.759386ms","start":"2026-08-24T15:14:35.191594Z","end":"2026-08-24T15:14:35.325354Z","steps":["trace[1482868114] 'process raft request' (duration: 131.165049ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:35.32575Z","caller":"traceutil/trace.go:171","msg":"trace[322084834] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"121.147631ms","start":"2026-08-24T15:14:35.204593Z","end":"2026-08-24T15:14:35.325741Z","steps":["trace[322084834] 'process raft request' (duration: 118.39098ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:41.5085Z","caller":"traceutil/trace.go:171","msg":"trace[746710511] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"133.442476ms","start":"2026-08-24T15:14:41.375026Z","end":"2026-08-24T15:14:41.508469Z","steps":["trace[746710511] 'read index received' (duration: 132.597944ms)","trace[746710511] 'applied index is now lower than readState.Index' (duration: 843.352µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:41.508687Z","caller":"traceutil/trace.go:171","msg":"trace[258423084] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"203.890709ms","start":"2026-08-24T15:14:41.304781Z","end":"2026-08-24T15:14:41.508671Z","steps":["trace[258423084] 'process raft request' (duration: 203.089269ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:41.50897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.904547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-678lz\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-08-24T15:14:41.508971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.885347ms","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-08-24T15:14:41.509093Z","caller":"traceutil/trace.go:171","msg":"trace[491710131] range","detail":"{range_begin:/registry/pods/kube-system/cilium-678lz; range_end:; response_count:1; response_revision:594; }","duration":"110.102892ms","start":"2026-08-24T15:14:41.39896Z","end":"2026-08-24T15:14:41.509063Z","steps":["trace[491710131] 'agreement among raft nodes before linearized reading' (duration: 109.800094ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:41.509091Z","caller":"traceutil/trace.go:171","msg":"trace[1047716804] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:594; }","duration":"134.057611ms","start":"2026-08-24T15:14:41.375014Z","end":"2026-08-24T15:14:41.509072Z","steps":["trace[1047716804] 'agreement among raft nodes before linearized reading' (duration: 133.795855ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:14:41.663433Z","caller":"traceutil/trace.go:171","msg":"trace[990907402] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"139.243094ms","start":"2026-08-24T15:14:41.524167Z","end":"2026-08-24T15:14:41.66341Z","steps":["trace[990907402] 'process raft request' (duration: 126.649774ms)","trace[990907402] 'compare' (duration: 12.18512ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:14:42.213849Z","caller":"traceutil/trace.go:171","msg":"trace[682856640] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"136.698152ms","start":"2026-08-24T15:14:42.077104Z","end":"2026-08-24T15:14:42.213802Z","steps":["trace[682856640] 'process raft request' (duration: 135.864951ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:14:56.302442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.300863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:14:56.30255Z","caller":"traceutil/trace.go:171","msg":"trace[728743415] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:758; }","duration":"187.464107ms","start":"2026-08-24T15:14:56.115068Z","end":"2026-08-24T15:14:56.302532Z","steps":["trace[728743415] 'range keys from in-memory index tree' (duration: 187.18506ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:12.517523Z","caller":"traceutil/trace.go:171","msg":"trace[2121834299] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"261.85529ms","start":"2026-08-24T15:16:12.255576Z","end":"2026-08-24T15:16:12.517432Z","steps":["trace[2121834299] 'process raft request' (duration: 261.688026ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:18.403044Z","caller":"traceutil/trace.go:171","msg":"trace[835674134] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"102.043717ms","start":"2026-08-24T15:16:18.300975Z","end":"2026-08-24T15:16:18.403018Z","steps":["trace[835674134] 'process raft request' (duration: 101.877273ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:16:51.727848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.498392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-24T15:16:51.727983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.79014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-24T15:16:51.728053Z","caller":"traceutil/trace.go:171","msg":"trace[89550013] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2101; }","duration":"170.908803ms","start":"2026-08-24T15:16:51.557132Z","end":"2026-08-24T15:16:51.728041Z","steps":["trace[89550013] 'range keys from in-memory index tree' (duration: 170.600765ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:51.727995Z","caller":"traceutil/trace.go:171","msg":"trace[831467508] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:2101; }","duration":"114.650765ms","start":"2026-08-24T15:16:51.613317Z","end":"2026-08-24T15:16:51.727968Z","steps":["trace[831467508] 'count revisions from in-memory index tree' (duration: 114.39375ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:52.146867Z","caller":"traceutil/trace.go:171","msg":"trace[1527354629] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"134.924095ms","start":"2026-08-24T15:16:52.011912Z","end":"2026-08-24T15:16:52.146836Z","steps":["trace[1527354629] 'process raft request' (duration: 134.73059ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:16:52.286553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.786474ms","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-08-24T15:16:52.286876Z","caller":"traceutil/trace.go:171","msg":"trace[1107658027] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2105; }","duration":"121.0444ms","start":"2026-08-24T15:16:52.165707Z","end":"2026-08-24T15:16:52.286751Z","steps":["trace[1107658027] 'range keys from in-memory index tree' (duration: 120.670511ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:52.413056Z","caller":"traceutil/trace.go:171","msg":"trace[752697539] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"120.713522ms","start":"2026-08-24T15:16:52.29231Z","end":"2026-08-24T15:16:52.413024Z","steps":["trace[752697539] 'process raft request' (duration: 120.245972ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:52.417661Z","caller":"traceutil/trace.go:171","msg":"trace[1940097002] linearizableReadLoop","detail":"{readStateIndex:2184; appliedIndex:2182; }","duration":"102.980159ms","start":"2026-08-24T15:16:52.314663Z","end":"2026-08-24T15:16:52.417643Z","steps":["trace[1940097002] 'read index received' (duration: 97.938605ms)","trace[1940097002] 'applied index is now lower than readState.Index' (duration: 5.040554ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:16:52.417856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.179473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-08-24T15:16:52.417947Z","caller":"traceutil/trace.go:171","msg":"trace[1954590440] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2108; }","duration":"103.312066ms","start":"2026-08-24T15:16:52.314603Z","end":"2026-08-24T15:16:52.417915Z","steps":["trace[1954590440] 'agreement among raft nodes before linearized reading' (duration: 103.122772ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:16:52.418136Z","caller":"traceutil/trace.go:171","msg":"trace[69591964] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"125.603423ms","start":"2026-08-24T15:16:52.292509Z","end":"2026-08-24T15:16:52.418113Z","steps":["trace[69591964] 'process raft request' (duration: 124.989259ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:18:16.155639Z","caller":"traceutil/trace.go:171","msg":"trace[2145064508] transaction","detail":"{read_only:false; response_revision:2666; number_of_response:1; }","duration":"137.938692ms","start":"2026-08-24T15:18:16.01764Z","end":"2026-08-24T15:18:16.155579Z","steps":["trace[2145064508] 'process raft request' (duration: 38.008716ms)","trace[2145064508] 'compare' (duration: 99.577894ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:21:58.840978Z","caller":"traceutil/trace.go:171","msg":"trace[823835803] transaction","detail":"{read_only:false; response_revision:4427; number_of_response:1; }","duration":"246.899623ms","start":"2026-08-24T15:21:58.594054Z","end":"2026-08-24T15:21:58.840953Z","steps":["trace[823835803] 'process raft request' (duration: 246.750419ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:21:59.062792Z","caller":"traceutil/trace.go:171","msg":"trace[364780978] transaction","detail":"{read_only:false; response_revision:4428; number_of_response:1; }","duration":"454.487824ms","start":"2026-08-24T15:21:58.608285Z","end":"2026-08-24T15:21:59.062773Z","steps":["trace[364780978] 'process raft request' (duration: 454.32077ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:59.062923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:58.608247Z","time spent":"454.610147ms","remote":"127.0.0.1:42598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1903,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:21:59.063278Z","caller":"traceutil/trace.go:171","msg":"trace[838580540] linearizableReadLoop","detail":"{readStateIndex:4596; appliedIndex:4593; }","duration":"437.19392ms","start":"2026-08-24T15:21:58.626063Z","end":"2026-08-24T15:21:59.063257Z","steps":["trace[838580540] 'read index received' (duration: 214.947911ms)","trace[838580540] 'applied index is now lower than readState.Index' (duration: 222.245349ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:21:59.063262Z","caller":"traceutil/trace.go:171","msg":"trace[864268991] transaction","detail":"{read_only:false; response_revision:4429; number_of_response:1; }","duration":"454.643948ms","start":"2026-08-24T15:21:58.608584Z","end":"2026-08-24T15:21:59.063227Z","steps":["trace[864268991] 'process raft request' (duration: 454.144565ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:21:59.063364Z","caller":"traceutil/trace.go:171","msg":"trace[895402603] transaction","detail":"{read_only:false; response_revision:4431; number_of_response:1; }","duration":"383.641854ms","start":"2026-08-24T15:21:58.679715Z","end":"2026-08-24T15:21:59.063357Z","steps":["trace[895402603] 'process raft request' (duration: 383.46312ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:21:59.063392Z","caller":"traceutil/trace.go:171","msg":"trace[1092994437] transaction","detail":"{read_only:false; response_revision:4430; number_of_response:1; }","duration":"453.217472ms","start":"2026-08-24T15:21:58.610162Z","end":"2026-08-24T15:21:59.063379Z","steps":["trace[1092994437] 'process raft request' (duration: 452.921914ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:59.063452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:58.608574Z","time spent":"454.790312ms","remote":"127.0.0.1:42504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1329,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:21:59.063477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:58.610149Z","time spent":"453.275753ms","remote":"127.0.0.1:42800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5194,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:21:59.063517Z","caller":"traceutil/trace.go:171","msg":"trace[752619318] transaction","detail":"{read_only:false; response_revision:4432; number_of_response:1; }","duration":"373.308469ms","start":"2026-08-24T15:21:58.690198Z","end":"2026-08-24T15:21:59.063506Z","steps":["trace[752619318] 'process raft request' (duration: 373.027482ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:59.063557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:58.679683Z","time spent":"383.725877ms","remote":"127.0.0.1:42586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:21:59.063574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:58.690176Z","time spent":"373.37248ms","remote":"127.0.0.1:42586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:21:59.063758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.678303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-08-24T15:21:59.063826Z","caller":"traceutil/trace.go:171","msg":"trace[1454865524] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4432; }","duration":"437.776375ms","start":"2026-08-24T15:21:58.626031Z","end":"2026-08-24T15:21:59.063807Z","steps":["trace[1454865524] 'agreement among raft nodes before linearized reading' (duration: 437.56882ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:59.063874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:58.626016Z","time spent":"437.845097ms","remote":"127.0.0.1:42532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":919,"request content":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" "} {"level":"info","ts":"2026-08-24T15:21:59.20243Z","caller":"traceutil/trace.go:171","msg":"trace[1309848310] transaction","detail":"{read_only:false; response_revision:4433; number_of_response:1; }","duration":"220.660195ms","start":"2026-08-24T15:21:58.981746Z","end":"2026-08-24T15:21:59.202407Z","steps":["trace[1309848310] 'process raft request' (duration: 220.47196ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:21:59.20255Z","caller":"traceutil/trace.go:171","msg":"trace[145186263] linearizableReadLoop","detail":"{readStateIndex:4600; appliedIndex:4598; }","duration":"139.187153ms","start":"2026-08-24T15:21:59.063337Z","end":"2026-08-24T15:21:59.202524Z","steps":["trace[145186263] 'read index received' (duration: 138.915486ms)","trace[145186263] 'applied index is now lower than readState.Index' (duration: 270.587µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:21:59.202633Z","caller":"traceutil/trace.go:171","msg":"trace[2094353342] transaction","detail":"{read_only:false; response_revision:4434; number_of_response:1; }","duration":"164.220867ms","start":"2026-08-24T15:21:59.038393Z","end":"2026-08-24T15:21:59.202614Z","steps":["trace[2094353342] 'process raft request' (duration: 163.97728ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:59.202682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.332726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4b196964-afb2-4a72-adfe-15d02fbd1568\" ","response":"range_response_count:1 size:3774"} {"level":"warn","ts":"2026-08-24T15:21:59.202708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.174477ms","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-08-24T15:21:59.202724Z","caller":"traceutil/trace.go:171","msg":"trace[1955448221] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4b196964-afb2-4a72-adfe-15d02fbd1568; range_end:; response_count:1; response_revision:4434; }","duration":"232.415337ms","start":"2026-08-24T15:21:58.970299Z","end":"2026-08-24T15:21:59.202715Z","steps":["trace[1955448221] 'agreement among raft nodes before linearized reading' (duration: 232.271594ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:21:59.202734Z","caller":"traceutil/trace.go:171","msg":"trace[962524067] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4434; }","duration":"472.236038ms","start":"2026-08-24T15:21:58.73049Z","end":"2026-08-24T15:21:59.202726Z","steps":["trace[962524067] 'agreement among raft nodes before linearized reading' (duration: 472.125256ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:59.202737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.798085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-08-24T15:21:59.202767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:58.730476Z","time spent":"472.285619ms","remote":"127.0.0.1:42586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-24T15:21:59.20279Z","caller":"traceutil/trace.go:171","msg":"trace[1443909889] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4434; }","duration":"534.851747ms","start":"2026-08-24T15:21:58.667923Z","end":"2026-08-24T15:21:59.202775Z","steps":["trace[1443909889] 'agreement among raft nodes before linearized reading' (duration: 534.717293ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:59.202808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.271504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1825"} {"level":"warn","ts":"2026-08-24T15:21:59.202924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:58.667868Z","time spent":"535.035752ms","remote":"127.0.0.1:42518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-08-24T15:21:59.203022Z","caller":"traceutil/trace.go:171","msg":"trace[1128151405] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4434; }","duration":"566.428718ms","start":"2026-08-24T15:21:58.636506Z","end":"2026-08-24T15:21:59.202934Z","steps":["trace[1128151405] 'agreement among raft nodes before linearized reading' (duration: 566.144961ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:59.203101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:21:58.636497Z","time spent":"566.587133ms","remote":"127.0.0.1:42420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1847,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"info","ts":"2026-08-24T15:21:59.364407Z","caller":"traceutil/trace.go:171","msg":"trace[1369883363] linearizableReadLoop","detail":"{readStateIndex:4601; appliedIndex:4600; }","duration":"161.771144ms","start":"2026-08-24T15:21:59.202601Z","end":"2026-08-24T15:21:59.364372Z","steps":["trace[1369883363] 'read index received' (duration: 161.481786ms)","trace[1369883363] 'applied index is now lower than readState.Index' (duration: 288.327µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:21:59.36445Z","caller":"traceutil/trace.go:171","msg":"trace[1829626736] transaction","detail":"{read_only:false; response_revision:4435; number_of_response:1; }","duration":"295.061865ms","start":"2026-08-24T15:21:59.069344Z","end":"2026-08-24T15:21:59.364406Z","steps":["trace[1829626736] 'process raft request' (duration: 294.764658ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:59.364519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.374061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-24T15:21:59.364626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.149255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5bf50a76-3bf6-4eb9-92af-2555c3f5f3fb\" ","response":"range_response_count:1 size:3760"} {"level":"info","ts":"2026-08-24T15:21:59.364662Z","caller":"traceutil/trace.go:171","msg":"trace[122056543] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5bf50a76-3bf6-4eb9-92af-2555c3f5f3fb; range_end:; response_count:1; response_revision:4435; }","duration":"298.211987ms","start":"2026-08-24T15:21:59.066439Z","end":"2026-08-24T15:21:59.364651Z","steps":["trace[122056543] 'agreement among raft nodes before linearized reading' (duration: 298.071893ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:21:59.364662Z","caller":"traceutil/trace.go:171","msg":"trace[680814183] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4435; }","duration":"247.529035ms","start":"2026-08-24T15:21:59.117082Z","end":"2026-08-24T15:21:59.364611Z","steps":["trace[680814183] 'agreement among raft nodes before linearized reading' (duration: 247.33292ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:21:59.393841Z","caller":"traceutil/trace.go:171","msg":"trace[1367012768] transaction","detail":"{read_only:false; response_revision:4436; number_of_response:1; }","duration":"186.719924ms","start":"2026-08-24T15:21:59.20709Z","end":"2026-08-24T15:21:59.39381Z","steps":["trace[1367012768] 'process raft request' (duration: 186.53564ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:59.394685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.593136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-08-24T15:21:59.394746Z","caller":"traceutil/trace.go:171","msg":"trace[2009094170] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4436; }","duration":"187.703159ms","start":"2026-08-24T15:21:59.207029Z","end":"2026-08-24T15:21:59.394732Z","steps":["trace[2009094170] 'agreement among raft nodes before linearized reading' (duration: 187.505394ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:21:59.395167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.530359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-08-24T15:21:59.395266Z","caller":"traceutil/trace.go:171","msg":"trace[768754437] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4436; }","duration":"170.663891ms","start":"2026-08-24T15:21:59.224582Z","end":"2026-08-24T15:21:59.395246Z","steps":["trace[768754437] 'agreement among raft nodes before linearized reading' (duration: 170.455076ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:00.064307Z","caller":"traceutil/trace.go:171","msg":"trace[234314131] linearizableReadLoop","detail":"{readStateIndex:4612; appliedIndex:4611; }","duration":"191.690591ms","start":"2026-08-24T15:21:59.872563Z","end":"2026-08-24T15:22:00.064253Z","steps":["trace[234314131] 'read index received' (duration: 191.509876ms)","trace[234314131] 'applied index is now lower than readState.Index' (duration: 179.995µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:22:00.064384Z","caller":"traceutil/trace.go:171","msg":"trace[1452992545] transaction","detail":"{read_only:false; response_revision:4445; number_of_response:1; }","duration":"199.793848ms","start":"2026-08-24T15:21:59.864555Z","end":"2026-08-24T15:22:00.064349Z","steps":["trace[1452992545] 'process raft request' (duration: 199.583223ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:00.064475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.834042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:22:00.064514Z","caller":"traceutil/trace.go:171","msg":"trace[1534342838] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:4445; }","duration":"157.929984ms","start":"2026-08-24T15:21:59.906572Z","end":"2026-08-24T15:22:00.064502Z","steps":["trace[1534342838] 'agreement among raft nodes before linearized reading' (duration: 157.831662ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:00.065105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.463461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-08-24T15:22:00.065232Z","caller":"traceutil/trace.go:171","msg":"trace[583807402] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4445; }","duration":"192.671736ms","start":"2026-08-24T15:21:59.872523Z","end":"2026-08-24T15:22:00.065195Z","steps":["trace[583807402] 'agreement among raft nodes before linearized reading' (duration: 191.831785ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:00.650787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.994708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5bf50a76-3bf6-4eb9-92af-2555c3f5f3fb\" ","response":"range_response_count:1 size:3760"} {"level":"info","ts":"2026-08-24T15:22:00.65088Z","caller":"traceutil/trace.go:171","msg":"trace[1186791758] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5bf50a76-3bf6-4eb9-92af-2555c3f5f3fb; range_end:; response_count:1; response_revision:4453; }","duration":"148.13379ms","start":"2026-08-24T15:22:00.502726Z","end":"2026-08-24T15:22:00.65086Z","steps":["trace[1186791758] 'range keys from in-memory index tree' (duration: 147.810083ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:00.954826Z","caller":"traceutil/trace.go:171","msg":"trace[1734541881] transaction","detail":"{read_only:false; response_revision:4454; number_of_response:1; }","duration":"296.535719ms","start":"2026-08-24T15:22:00.658265Z","end":"2026-08-24T15:22:00.954801Z","steps":["trace[1734541881] 'process raft request' (duration: 296.382585ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:01.141445Z","caller":"traceutil/trace.go:171","msg":"trace[1571722980] transaction","detail":"{read_only:false; response_revision:4455; number_of_response:1; }","duration":"176.758174ms","start":"2026-08-24T15:22:00.96464Z","end":"2026-08-24T15:22:01.141399Z","steps":["trace[1571722980] 'process raft request' (duration: 176.393114ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:01.196776Z","caller":"traceutil/trace.go:171","msg":"trace[318414334] transaction","detail":"{read_only:false; response_revision:4456; number_of_response:1; }","duration":"128.515386ms","start":"2026-08-24T15:22:01.068198Z","end":"2026-08-24T15:22:01.196714Z","steps":["trace[318414334] 'process raft request' (duration: 128.29048ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:01.196842Z","caller":"traceutil/trace.go:171","msg":"trace[1655795531] transaction","detail":"{read_only:false; response_revision:4457; number_of_response:1; }","duration":"127.635333ms","start":"2026-08-24T15:22:01.069168Z","end":"2026-08-24T15:22:01.196804Z","steps":["trace[1655795531] 'process raft request' (duration: 127.456089ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:02.767843Z","caller":"traceutil/trace.go:171","msg":"trace[738269885] transaction","detail":"{read_only:false; response_revision:4491; number_of_response:1; }","duration":"101.0281ms","start":"2026-08-24T15:22:02.666788Z","end":"2026-08-24T15:22:02.767816Z","steps":["trace[738269885] 'process raft request' (duration: 64.853383ms)","trace[738269885] 'compare' (duration: 35.442018ms)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:22:14.374427Z","caller":"traceutil/trace.go:171","msg":"trace[2119024188] linearizableReadLoop","detail":"{readStateIndex:4850; appliedIndex:4849; }","duration":"111.437929ms","start":"2026-08-24T15:22:14.26296Z","end":"2026-08-24T15:22:14.374398Z","steps":["trace[2119024188] 'read index received' (duration: 111.126421ms)","trace[2119024188] 'applied index is now lower than readState.Index' (duration: 310.368µs)"],"step_count":2} {"level":"info","ts":"2026-08-24T15:22:14.374493Z","caller":"traceutil/trace.go:171","msg":"trace[1437656704] transaction","detail":"{read_only:false; response_revision:4679; number_of_response:1; }","duration":"135.565114ms","start":"2026-08-24T15:22:14.238884Z","end":"2026-08-24T15:22:14.374449Z","steps":["trace[1437656704] 'process raft request' (duration: 135.311188ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:14.374783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.780738ms","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-08-24T15:22:14.374894Z","caller":"traceutil/trace.go:171","msg":"trace[1752190299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4679; }","duration":"111.946452ms","start":"2026-08-24T15:22:14.262925Z","end":"2026-08-24T15:22:14.374871Z","steps":["trace[1752190299] 'agreement among raft nodes before linearized reading' (duration: 111.630514ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:29.495627Z","caller":"traceutil/trace.go:171","msg":"trace[216315815] transaction","detail":"{read_only:false; response_revision:4868; number_of_response:1; }","duration":"152.846458ms","start":"2026-08-24T15:22:29.342758Z","end":"2026-08-24T15:22:29.495604Z","steps":["trace[216315815] 'process raft request' (duration: 152.677684ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:29.869539Z","caller":"traceutil/trace.go:171","msg":"trace[2010126902] transaction","detail":"{read_only:false; response_revision:4871; number_of_response:1; }","duration":"291.830094ms","start":"2026-08-24T15:22:29.577692Z","end":"2026-08-24T15:22:29.869522Z","steps":["trace[2010126902] 'process raft request' (duration: 291.807534ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:29.869738Z","caller":"traceutil/trace.go:171","msg":"trace[1174699951] transaction","detail":"{read_only:false; response_revision:4869; number_of_response:1; }","duration":"450.588422ms","start":"2026-08-24T15:22:29.419144Z","end":"2026-08-24T15:22:29.869732Z","steps":["trace[1174699951] 'process raft request' (duration: 359.432015ms)","trace[1174699951] 'compare' (duration: 90.791967ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:22:29.869798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:22:29.419108Z","time spent":"450.641983ms","remote":"127.0.0.1:42586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:22:29.869871Z","caller":"traceutil/trace.go:171","msg":"trace[781955314] transaction","detail":"{read_only:false; response_revision:4870; number_of_response:1; }","duration":"431.077978ms","start":"2026-08-24T15:22:29.438786Z","end":"2026-08-24T15:22:29.869864Z","steps":["trace[781955314] 'process raft request' (duration: 430.670378ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:29.869894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:22:29.438762Z","time spent":"431.118459ms","remote":"127.0.0.1:42586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:22:29.869995Z","caller":"traceutil/trace.go:171","msg":"trace[1594520449] linearizableReadLoop","detail":"{readStateIndex:5047; appliedIndex:5044; }","duration":"429.299533ms","start":"2026-08-24T15:22:29.440683Z","end":"2026-08-24T15:22:29.869982Z","steps":["trace[1594520449] 'read index received' (duration: 54.753126ms)","trace[1594520449] 'applied index is now lower than readState.Index' (duration: 374.545167ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:22:29.870085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.396255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-24T15:22:29.870107Z","caller":"traceutil/trace.go:171","msg":"trace[515766204] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:4871; }","duration":"429.454067ms","start":"2026-08-24T15:22:29.440646Z","end":"2026-08-24T15:22:29.870101Z","steps":["trace[515766204] 'agreement among raft nodes before linearized reading' (duration: 429.403546ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:29.870127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:22:29.440633Z","time spent":"429.489247ms","remote":"127.0.0.1:42626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":4,"response size":29,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-08-24T15:22:29.886138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.604985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.200\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-24T15:22:29.886201Z","caller":"traceutil/trace.go:171","msg":"trace[449142452] range","detail":"{range_begin:/registry/masterleases/199.19.213.200; range_end:; response_count:1; response_revision:4872; }","duration":"345.716258ms","start":"2026-08-24T15:22:29.540471Z","end":"2026-08-24T15:22:29.886187Z","steps":["trace[449142452] 'agreement among raft nodes before linearized reading' (duration: 345.436541ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:29.886237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:22:29.540452Z","time spent":"345.777609ms","remote":"127.0.0.1:42358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.19.213.200\" "} {"level":"warn","ts":"2026-08-24T15:22:29.886292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.968071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-08-24T15:22:29.886329Z","caller":"traceutil/trace.go:171","msg":"trace[395686475] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4872; }","duration":"155.037823ms","start":"2026-08-24T15:22:29.731281Z","end":"2026-08-24T15:22:29.886319Z","steps":["trace[395686475] 'agreement among raft nodes before linearized reading' (duration: 154.954441ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:29.886517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.986008ms","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-08-24T15:22:29.886595Z","caller":"traceutil/trace.go:171","msg":"trace[1135534125] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4872; }","duration":"224.183183ms","start":"2026-08-24T15:22:29.662394Z","end":"2026-08-24T15:22:29.886577Z","steps":["trace[1135534125] 'agreement among raft nodes before linearized reading' (duration: 223.891725ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:22:30.009915Z","caller":"traceutil/trace.go:171","msg":"trace[636107435] transaction","detail":"{read_only:false; response_revision:4875; number_of_response:1; }","duration":"110.793953ms","start":"2026-08-24T15:22:29.899021Z","end":"2026-08-24T15:22:30.009815Z","steps":["trace[636107435] 'process raft request' (duration: 94.690016ms)","trace[636107435] 'compare' (duration: 15.940733ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:22:30.2355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.148434ms","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-08-24T15:22:30.235565Z","caller":"traceutil/trace.go:171","msg":"trace[1594673144] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4875; }","duration":"119.317699ms","start":"2026-08-24T15:22:30.116234Z","end":"2026-08-24T15:22:30.235552Z","steps":["trace[1594673144] 'range keys from in-memory index tree' (duration: 119.053862ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:22:30.236079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.774244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:22:30.236161Z","caller":"traceutil/trace.go:171","msg":"trace[785355707] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4875; }","duration":"119.511023ms","start":"2026-08-24T15:22:30.116631Z","end":"2026-08-24T15:22:30.236142Z","steps":["trace[785355707] 'range keys from in-memory index tree' (duration: 118.719063ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:23:06.877685Z","caller":"traceutil/trace.go:171","msg":"trace[929038569] transaction","detail":"{read_only:false; response_revision:5203; number_of_response:1; }","duration":"735.742988ms","start":"2026-08-24T15:23:06.141913Z","end":"2026-08-24T15:23:06.877656Z","steps":["trace[929038569] 'process raft request' (duration: 732.938438ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:23:06.879193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:23:06.141895Z","time spent":"736.913878ms","remote":"127.0.0.1:42586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:23:06.956837Z","caller":"traceutil/trace.go:171","msg":"trace[1334026487] transaction","detail":"{read_only:false; response_revision:5204; number_of_response:1; }","duration":"801.095629ms","start":"2026-08-24T15:23:06.155731Z","end":"2026-08-24T15:23:06.956826Z","steps":["trace[1334026487] 'process raft request' (duration: 800.506355ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:23:06.956873Z","caller":"traceutil/trace.go:171","msg":"trace[875646800] transaction","detail":"{read_only:false; response_revision:5205; number_of_response:1; }","duration":"678.185842ms","start":"2026-08-24T15:23:06.278662Z","end":"2026-08-24T15:23:06.956847Z","steps":["trace[875646800] 'process raft request' (duration: 678.017948ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:23:06.956929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:23:06.155708Z","time spent":"801.16527ms","remote":"127.0.0.1:42586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-24T15:23:06.957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:23:06.278641Z","time spent":"678.277054ms","remote":"127.0.0.1:42586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-24T15:23:06.956772Z","caller":"traceutil/trace.go:171","msg":"trace[665652213] linearizableReadLoop","detail":"{readStateIndex:5392; appliedIndex:5389; }","duration":"326.611878ms","start":"2026-08-24T15:23:06.630141Z","end":"2026-08-24T15:23:06.956753Z","steps":["trace[665652213] 'read index received' (duration: 244.725655ms)","trace[665652213] 'applied index is now lower than readState.Index' (duration: 81.885343ms)"],"step_count":2} {"level":"warn","ts":"2026-08-24T15:23:06.95751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.753333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:23:06.957542Z","caller":"traceutil/trace.go:171","msg":"trace[1735836501] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5205; }","duration":"201.815215ms","start":"2026-08-24T15:23:06.75572Z","end":"2026-08-24T15:23:06.957535Z","steps":["trace[1735836501] 'agreement among raft nodes before linearized reading' (duration: 201.408145ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:23:06.957593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.329938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6084"} {"level":"warn","ts":"2026-08-24T15:23:06.9576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.055262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-24T15:23:06.957648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.814975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-24T15:23:06.95765Z","caller":"traceutil/trace.go:171","msg":"trace[117999331] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:5205; }","duration":"200.385779ms","start":"2026-08-24T15:23:06.757248Z","end":"2026-08-24T15:23:06.957633Z","steps":["trace[117999331] 'agreement among raft nodes before linearized reading' (duration: 200.121963ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:23:06.957656Z","caller":"traceutil/trace.go:171","msg":"trace[1789761109] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5205; }","duration":"164.121335ms","start":"2026-08-24T15:23:06.79352Z","end":"2026-08-24T15:23:06.957641Z","steps":["trace[1789761109] 'agreement among raft nodes before linearized reading' (duration: 163.974641ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:23:06.957667Z","caller":"traceutil/trace.go:171","msg":"trace[1894481895] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5205; }","duration":"201.873396ms","start":"2026-08-24T15:23:06.75579Z","end":"2026-08-24T15:23:06.957663Z","steps":["trace[1894481895] 'agreement among raft nodes before linearized reading' (duration: 201.835655ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:23:06.957851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.296293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-24T15:23:06.95791Z","caller":"traceutil/trace.go:171","msg":"trace[1139108024] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5205; }","duration":"165.371685ms","start":"2026-08-24T15:23:06.792524Z","end":"2026-08-24T15:23:06.957895Z","steps":["trace[1139108024] 'agreement among raft nodes before linearized reading' (duration: 164.650677ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:23:06.957946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.756467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-08-24T15:23:06.958065Z","caller":"traceutil/trace.go:171","msg":"trace[23026331] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5205; }","duration":"327.962662ms","start":"2026-08-24T15:23:06.630087Z","end":"2026-08-24T15:23:06.95805Z","steps":["trace[23026331] 'agreement among raft nodes before linearized reading' (duration: 327.014738ms)"],"step_count":1} {"level":"warn","ts":"2026-08-24T15:23:06.958128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-24T15:23:06.630066Z","time spent":"328.051474ms","remote":"127.0.0.1:42586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-24T15:23:56.493447Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2880} {"level":"info","ts":"2026-08-24T15:23:56.569442Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2880,"took":"74.512624ms","hash":896242268,"current-db-size-bytes":54841344,"current-db-size":"55 MB","current-db-size-in-use-bytes":29212672,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-24T15:23:56.569719Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":896242268,"revision":2880,"compact-revision":-1} {"level":"info","ts":"2026-08-24T15:26:14.962576Z","caller":"traceutil/trace.go:171","msg":"trace[214093503] transaction","detail":"{read_only:false; response_revision:6501; number_of_response:1; }","duration":"110.517748ms","start":"2026-08-24T15:26:14.851965Z","end":"2026-08-24T15:26:14.962483Z","steps":["trace[214093503] 'process raft request' (duration: 106.86597ms)"],"step_count":1} {"level":"info","ts":"2026-08-24T15:28:56.499641Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5550} {"level":"info","ts":"2026-08-24T15:28:56.584905Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5550,"took":"83.758727ms","hash":2726446456,"current-db-size-bytes":54841344,"current-db-size":"55 MB","current-db-size-in-use-bytes":18120704,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-24T15:28:56.584986Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2726446456,"revision":5550,"compact-revision":2880}