{"level":"warn","ts":"2026-03-11T17:04:54.932425Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-11T17:04:54.932521Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.49: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.49:2380","--initial-cluster=instance=https://199.204.45.49:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.49:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.49:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-03-11T17:04:54.932585Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-11T17:04:54.932598Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.49:2380"]} {"level":"info","ts":"2026-03-11T17:04:54.932625Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-03-11T17:04:54.933404Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"]} {"level":"info","ts":"2026-03-11T17:04:54.933735Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.49:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-03-11T17:04:54.938073Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.093728ms"} {"level":"info","ts":"2026-03-11T17:04:54.953993Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d0ba3c4de8c6ef7a","cluster-id":"e76701b877f442ac"} {"level":"info","ts":"2026-03-11T17:04:54.954088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=()"} {"level":"info","ts":"2026-03-11T17:04:54.95411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 0"} {"level":"info","ts":"2026-03-11T17:04:54.954131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d0ba3c4de8c6ef7a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-11T17:04:54.954142Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became follower at term 1"} {"level":"info","ts":"2026-03-11T17:04:54.954184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"} {"level":"warn","ts":"2026-03-11T17:04:54.959589Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-11T17:04:54.968274Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-11T17:04:54.969578Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-03-11T17:04:54.97255Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d0ba3c4de8c6ef7a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-11T17:04:54.973139Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d0ba3c4de8c6ef7a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-11T17:04:54.973425Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-11T17:04:54.974605Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-11T17:04:54.974646Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-11T17:04:54.975131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a switched to configuration voters=(15040400210872692602)"} {"level":"info","ts":"2026-03-11T17:04:54.97526Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","added-peer-id":"d0ba3c4de8c6ef7a","added-peer-peer-urls":["https://199.204.45.49:2380"]} {"level":"info","ts":"2026-03-11T17:04:54.976777Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-03-11T17:04:54.976902Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.49:2380"} {"level":"info","ts":"2026-03-11T17:04:54.976951Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.49:2380"} {"level":"info","ts":"2026-03-11T17:04:54.977121Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d0ba3c4de8c6ef7a","initial-advertise-peer-urls":["https://199.204.45.49:2380"],"listen-peer-urls":["https://199.204.45.49:2380"],"advertise-client-urls":["https://199.204.45.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-11T17:04:54.977171Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-11T17:04:55.85513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a is starting a new election at term 1"} {"level":"info","ts":"2026-03-11T17:04:55.855227Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became pre-candidate at term 1"} {"level":"info","ts":"2026-03-11T17:04:55.855258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgPreVoteResp from d0ba3c4de8c6ef7a at term 1"} {"level":"info","ts":"2026-03-11T17:04:55.855284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became candidate at term 2"} {"level":"info","ts":"2026-03-11T17:04:55.855302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a received MsgVoteResp from d0ba3c4de8c6ef7a at term 2"} {"level":"info","ts":"2026-03-11T17:04:55.855321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d0ba3c4de8c6ef7a became leader at term 2"} {"level":"info","ts":"2026-03-11T17:04:55.85534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d0ba3c4de8c6ef7a elected leader d0ba3c4de8c6ef7a at term 2"} {"level":"info","ts":"2026-03-11T17:04:55.860613Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d0ba3c4de8c6ef7a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.49:2379]}","request-path":"/0/members/d0ba3c4de8c6ef7a/attributes","cluster-id":"e76701b877f442ac","publish-timeout":"7s"} {"level":"info","ts":"2026-03-11T17:04:55.860652Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-11T17:04:55.860731Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-11T17:04:55.860834Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-11T17:04:55.861067Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-11T17:04:55.861092Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-11T17:04:55.862486Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e76701b877f442ac","local-member-id":"d0ba3c4de8c6ef7a","cluster-version":"3.5"} {"level":"info","ts":"2026-03-11T17:04:55.86263Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-11T17:04:55.862679Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-11T17:04:55.863988Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.49:2379"} {"level":"info","ts":"2026-03-11T17:04:55.864037Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-03-11T17:05:19.298141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.223731ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-11T17:05:19.298427Z","caller":"traceutil/trace.go:171","msg":"trace[2140733290] linearizableReadLoop","detail":"{readStateIndex:472; appliedIndex:471; }","duration":"154.820886ms","start":"2026-03-11T17:05:19.143542Z","end":"2026-03-11T17:05:19.298363Z","steps":["trace[2140733290] 'read index received' (duration: 9.319968ms)","trace[2140733290] 'applied index is now lower than readState.Index' (duration: 145.499338ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:05:19.298467Z","caller":"traceutil/trace.go:171","msg":"trace[205288518] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"225.958343ms","start":"2026-03-11T17:05:19.072453Z","end":"2026-03-11T17:05:19.298412Z","steps":["trace[205288518] 'process raft request' (duration: 80.497177ms)","trace[205288518] 'compare' (duration: 144.100598ms)"],"step_count":2} {"level":"warn","ts":"2026-03-11T17:05:19.298635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.057973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-03-11T17:05:19.298698Z","caller":"traceutil/trace.go:171","msg":"trace[920821862] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:457; }","duration":"155.182657ms","start":"2026-03-11T17:05:19.143499Z","end":"2026-03-11T17:05:19.298682Z","steps":["trace[920821862] 'agreement among raft nodes before linearized reading' (duration: 155.004142ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:06:02.269015Z","caller":"traceutil/trace.go:171","msg":"trace[710635941] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"228.352356ms","start":"2026-03-11T17:06:02.040631Z","end":"2026-03-11T17:06:02.268983Z","steps":["trace[710635941] 'process raft request' (duration: 164.528211ms)","trace[710635941] 'compare' (duration: 63.582418ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:06:02.269383Z","caller":"traceutil/trace.go:171","msg":"trace[401984389] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"227.988147ms","start":"2026-03-11T17:06:02.041347Z","end":"2026-03-11T17:06:02.269335Z","steps":["trace[401984389] 'process raft request' (duration: 227.564044ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:06:02.269566Z","caller":"traceutil/trace.go:171","msg":"trace[649267193] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"226.704672ms","start":"2026-03-11T17:06:02.042822Z","end":"2026-03-11T17:06:02.269527Z","steps":["trace[649267193] 'process raft request' (duration: 226.385643ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:06:53.37742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.592685ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-11T17:06:53.377662Z","caller":"traceutil/trace.go:171","msg":"trace[1552296749] linearizableReadLoop","detail":"{readStateIndex:1684; appliedIndex:1683; }","duration":"151.283903ms","start":"2026-03-11T17:06:53.226352Z","end":"2026-03-11T17:06:53.377636Z","steps":["trace[1552296749] 'read index received' (duration: 48.491µs)","trace[1552296749] 'applied index is now lower than readState.Index' (duration: 151.233482ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:06:53.377774Z","caller":"traceutil/trace.go:171","msg":"trace[861626949] transaction","detail":"{read_only:false; response_revision:1620; number_of_response:1; }","duration":"328.796376ms","start":"2026-03-11T17:06:53.048923Z","end":"2026-03-11T17:06:53.377719Z","steps":["trace[861626949] 'process raft request' (duration: 64.81797ms)","trace[861626949] 'compare' (duration: 263.378729ms)"],"step_count":2} {"level":"warn","ts":"2026-03-11T17:06:53.377873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.52255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3e766bc3-f6b8-443b-9907-7290b6cffac0\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-03-11T17:06:53.377904Z","caller":"traceutil/trace.go:171","msg":"trace[1904345712] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3e766bc3-f6b8-443b-9907-7290b6cffac0; range_end:; response_count:1; response_revision:1620; }","duration":"151.584682ms","start":"2026-03-11T17:06:53.226309Z","end":"2026-03-11T17:06:53.377893Z","steps":["trace[1904345712] 'agreement among raft nodes before linearized reading' (duration: 151.443038ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:06:53.378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T17:06:53.048891Z","time spent":"328.988202ms","remote":"127.0.0.1:47088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-11T17:06:53.78747Z","caller":"traceutil/trace.go:171","msg":"trace[749149715] transaction","detail":"{read_only:false; response_revision:1628; number_of_response:1; }","duration":"127.552574ms","start":"2026-03-11T17:06:53.659887Z","end":"2026-03-11T17:06:53.78744Z","steps":["trace[749149715] 'process raft request' (duration: 83.668709ms)","trace[749149715] 'compare' (duration: 43.655159ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:07:06.069385Z","caller":"traceutil/trace.go:171","msg":"trace[1774282089] linearizableReadLoop","detail":"{readStateIndex:1793; appliedIndex:1792; }","duration":"116.245487ms","start":"2026-03-11T17:07:05.953108Z","end":"2026-03-11T17:07:06.069354Z","steps":["trace[1774282089] 'read index received' (duration: 97.79216ms)","trace[1774282089] 'applied index is now lower than readState.Index' (duration: 18.451757ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:07:06.069491Z","caller":"traceutil/trace.go:171","msg":"trace[942313952] transaction","detail":"{read_only:false; response_revision:1725; number_of_response:1; }","duration":"231.665084ms","start":"2026-03-11T17:07:05.837752Z","end":"2026-03-11T17:07:06.069417Z","steps":["trace[942313952] 'process raft request' (duration: 213.221777ms)","trace[942313952] 'compare' (duration: 18.213111ms)"],"step_count":2} {"level":"warn","ts":"2026-03-11T17:07:06.069708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.566856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-03-11T17:07:06.069751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.445983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-03-11T17:07:06.069808Z","caller":"traceutil/trace.go:171","msg":"trace[130265034] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1725; }","duration":"116.71296ms","start":"2026-03-11T17:07:05.95307Z","end":"2026-03-11T17:07:06.069783Z","steps":["trace[130265034] 'agreement among raft nodes before linearized reading' (duration: 116.444903ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:07:06.069839Z","caller":"traceutil/trace.go:171","msg":"trace[583916475] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1725; }","duration":"116.615667ms","start":"2026-03-11T17:07:05.953211Z","end":"2026-03-11T17:07:06.069826Z","steps":["trace[583916475] 'agreement among raft nodes before linearized reading' (duration: 116.3567ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:07:42.435777Z","caller":"traceutil/trace.go:171","msg":"trace[1906752987] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"168.678925ms","start":"2026-03-11T17:07:42.267015Z","end":"2026-03-11T17:07:42.435694Z","steps":["trace[1906752987] 'process raft request' (duration: 98.527551ms)","trace[1906752987] 'compare' (duration: 69.870946ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:07:42.476097Z","caller":"traceutil/trace.go:171","msg":"trace[922296194] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"208.221782ms","start":"2026-03-11T17:07:42.267843Z","end":"2026-03-11T17:07:42.476065Z","steps":["trace[922296194] 'process raft request' (duration: 207.985186ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:07:42.476247Z","caller":"traceutil/trace.go:171","msg":"trace[1316779416] linearizableReadLoop","detail":"{readStateIndex:1993; appliedIndex:1991; }","duration":"138.311234ms","start":"2026-03-11T17:07:42.337665Z","end":"2026-03-11T17:07:42.475976Z","steps":["trace[1316779416] 'read index received' (duration: 27.930694ms)","trace[1316779416] 'applied index is now lower than readState.Index' (duration: 110.37909ms)"],"step_count":2} {"level":"warn","ts":"2026-03-11T17:07:42.476466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.783618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-03-11T17:07:42.476563Z","caller":"traceutil/trace.go:171","msg":"trace[1531967384] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1918; }","duration":"138.929131ms","start":"2026-03-11T17:07:42.337608Z","end":"2026-03-11T17:07:42.476537Z","steps":["trace[1531967384] 'agreement among raft nodes before linearized reading' (duration: 138.588152ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:07:48.328497Z","caller":"traceutil/trace.go:171","msg":"trace[1025215223] transaction","detail":"{read_only:false; response_revision:1944; number_of_response:1; }","duration":"101.946032ms","start":"2026-03-11T17:07:48.226522Z","end":"2026-03-11T17:07:48.328468Z","steps":["trace[1025215223] 'process raft request' (duration: 101.782767ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:07:48.594537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.042934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-03-11T17:07:48.594674Z","caller":"traceutil/trace.go:171","msg":"trace[2012806943] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1944; }","duration":"132.25049ms","start":"2026-03-11T17:07:48.462397Z","end":"2026-03-11T17:07:48.594648Z","steps":["trace[2012806943] 'range keys from in-memory index tree' (duration: 131.808898ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:07:48.731055Z","caller":"traceutil/trace.go:171","msg":"trace[16728754] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"131.643224ms","start":"2026-03-11T17:07:48.599388Z","end":"2026-03-11T17:07:48.731031Z","steps":["trace[16728754] 'process raft request' (duration: 131.483179ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:07:48.869318Z","caller":"traceutil/trace.go:171","msg":"trace[1970435684] transaction","detail":"{read_only:false; response_revision:1947; number_of_response:1; }","duration":"259.884546ms","start":"2026-03-11T17:07:48.609395Z","end":"2026-03-11T17:07:48.86928Z","steps":["trace[1970435684] 'process raft request' (duration: 259.783833ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:07:48.869373Z","caller":"traceutil/trace.go:171","msg":"trace[1278206687] transaction","detail":"{read_only:false; response_revision:1946; number_of_response:1; }","duration":"269.841104ms","start":"2026-03-11T17:07:48.599479Z","end":"2026-03-11T17:07:48.86932Z","steps":["trace[1278206687] 'process raft request' (duration: 269.521125ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:07:48.86944Z","caller":"traceutil/trace.go:171","msg":"trace[1587776716] linearizableReadLoop","detail":"{readStateIndex:2023; appliedIndex:2020; }","duration":"209.763673ms","start":"2026-03-11T17:07:48.65964Z","end":"2026-03-11T17:07:48.869404Z","steps":["trace[1587776716] 'read index received' (duration: 71.259654ms)","trace[1587776716] 'applied index is now lower than readState.Index' (duration: 138.500999ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:07:48.869494Z","caller":"traceutil/trace.go:171","msg":"trace[788665899] transaction","detail":"{read_only:false; response_revision:1948; number_of_response:1; }","duration":"171.733756ms","start":"2026-03-11T17:07:48.697699Z","end":"2026-03-11T17:07:48.869433Z","steps":["trace[788665899] 'process raft request' (duration: 171.536831ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:07:48.869726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.05579ms","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-03-11T17:07:48.869817Z","caller":"traceutil/trace.go:171","msg":"trace[1360495703] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1948; }","duration":"210.220206ms","start":"2026-03-11T17:07:48.659578Z","end":"2026-03-11T17:07:48.869798Z","steps":["trace[1360495703] 'agreement among raft nodes before linearized reading' (duration: 209.923368ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:07:48.869737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.225281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-11T17:07:48.869925Z","caller":"traceutil/trace.go:171","msg":"trace[1989637854] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1948; }","duration":"165.474317ms","start":"2026-03-11T17:07:48.704431Z","end":"2026-03-11T17:07:48.869906Z","steps":["trace[1989637854] 'agreement among raft nodes before linearized reading' (duration: 165.18066ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:09:06.210337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.761482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-11T17:09:06.210476Z","caller":"traceutil/trace.go:171","msg":"trace[670438946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2521; }","duration":"124.000359ms","start":"2026-03-11T17:09:06.086452Z","end":"2026-03-11T17:09:06.210452Z","steps":["trace[670438946] 'range keys from in-memory index tree' (duration: 123.424504ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:09:06.551365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.104011ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-11T17:09:06.551525Z","caller":"traceutil/trace.go:171","msg":"trace[1060655139] transaction","detail":"{read_only:false; response_revision:2523; number_of_response:1; }","duration":"200.242512ms","start":"2026-03-11T17:09:06.351255Z","end":"2026-03-11T17:09:06.551497Z","steps":["trace[1060655139] 'process raft request' (duration: 42.821682ms)","trace[1060655139] 'compare' (duration: 156.444174ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:11:42.247825Z","caller":"traceutil/trace.go:171","msg":"trace[764627320] linearizableReadLoop","detail":"{readStateIndex:3604; appliedIndex:3603; }","duration":"121.287897ms","start":"2026-03-11T17:11:42.126494Z","end":"2026-03-11T17:11:42.247782Z","steps":["trace[764627320] 'read index received' (duration: 121.084621ms)","trace[764627320] 'applied index is now lower than readState.Index' (duration: 201.706µs)"],"step_count":2} {"level":"warn","ts":"2026-03-11T17:11:42.248171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.502301ms","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":"warn","ts":"2026-03-11T17:11:42.248173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.659437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-03-11T17:11:42.248217Z","caller":"traceutil/trace.go:171","msg":"trace[620380270] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3465; }","duration":"118.595724ms","start":"2026-03-11T17:11:42.129609Z","end":"2026-03-11T17:11:42.248205Z","steps":["trace[620380270] 'agreement among raft nodes before linearized reading' (duration: 118.42959ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:11:42.248237Z","caller":"traceutil/trace.go:171","msg":"trace[586523942] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3465; }","duration":"121.787732ms","start":"2026-03-11T17:11:42.126435Z","end":"2026-03-11T17:11:42.248223Z","steps":["trace[586523942] 'agreement among raft nodes before linearized reading' (duration: 121.595026ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:11:42.248357Z","caller":"traceutil/trace.go:171","msg":"trace[919578487] transaction","detail":"{read_only:false; response_revision:3465; number_of_response:1; }","duration":"123.787635ms","start":"2026-03-11T17:11:42.124559Z","end":"2026-03-11T17:11:42.248347Z","steps":["trace[919578487] 'process raft request' (duration: 123.040834ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:13:06.478765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.998815ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-11T17:13:06.478917Z","caller":"traceutil/trace.go:171","msg":"trace[25050501] linearizableReadLoop","detail":"{readStateIndex:4770; appliedIndex:4769; }","duration":"175.686448ms","start":"2026-03-11T17:13:06.30321Z","end":"2026-03-11T17:13:06.478897Z","steps":["trace[25050501] 'read index received' (duration: 32.781µs)","trace[25050501] 'applied index is now lower than readState.Index' (duration: 175.652117ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:13:06.479036Z","caller":"traceutil/trace.go:171","msg":"trace[59974815] transaction","detail":"{read_only:false; response_revision:4587; number_of_response:1; }","duration":"288.849276ms","start":"2026-03-11T17:13:06.190127Z","end":"2026-03-11T17:13:06.478976Z","steps":["trace[59974815] 'process raft request' (duration: 41.546973ms)","trace[59974815] 'compare' (duration: 246.77885ms)"],"step_count":2} {"level":"warn","ts":"2026-03-11T17:13:06.479141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.921824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8300da6d-b4af-4ee1-8cff-181b9fdd4467\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-03-11T17:13:06.479188Z","caller":"traceutil/trace.go:171","msg":"trace[1490019690] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8300da6d-b4af-4ee1-8cff-181b9fdd4467; range_end:; response_count:1; response_revision:4587; }","duration":"176.009707ms","start":"2026-03-11T17:13:06.303164Z","end":"2026-03-11T17:13:06.479174Z","steps":["trace[1490019690] 'agreement among raft nodes before linearized reading' (duration: 175.825582ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:13:06.846295Z","caller":"traceutil/trace.go:171","msg":"trace[760691966] transaction","detail":"{read_only:false; response_revision:4598; number_of_response:1; }","duration":"169.073129ms","start":"2026-03-11T17:13:06.677184Z","end":"2026-03-11T17:13:06.846257Z","steps":["trace[760691966] 'process raft request' (duration: 144.828815ms)","trace[760691966] 'compare' (duration: 23.927696ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:13:06.894162Z","caller":"traceutil/trace.go:171","msg":"trace[1149319892] linearizableReadLoop","detail":"{readStateIndex:4782; appliedIndex:4780; }","duration":"189.493271ms","start":"2026-03-11T17:13:06.704643Z","end":"2026-03-11T17:13:06.894137Z","steps":["trace[1149319892] 'read index received' (duration: 117.415964ms)","trace[1149319892] 'applied index is now lower than readState.Index' (duration: 72.075937ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:13:06.894271Z","caller":"traceutil/trace.go:171","msg":"trace[1380621371] transaction","detail":"{read_only:false; response_revision:4599; number_of_response:1; }","duration":"205.622856ms","start":"2026-03-11T17:13:06.688601Z","end":"2026-03-11T17:13:06.894224Z","steps":["trace[1380621371] 'process raft request' (duration: 205.328478ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:13:06.894331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.661805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-11T17:13:06.894378Z","caller":"traceutil/trace.go:171","msg":"trace[221917437] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4599; }","duration":"189.764278ms","start":"2026-03-11T17:13:06.704599Z","end":"2026-03-11T17:13:06.894363Z","steps":["trace[221917437] 'agreement among raft nodes before linearized reading' (duration: 189.673446ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:13:06.93962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.225792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-03-11T17:13:06.939645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.183744ms","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-03-11T17:13:06.939725Z","caller":"traceutil/trace.go:171","msg":"trace[1421451706] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4600; }","duration":"126.384975ms","start":"2026-03-11T17:13:06.813318Z","end":"2026-03-11T17:13:06.939703Z","steps":["trace[1421451706] 'agreement among raft nodes before linearized reading' (duration: 126.067397ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:13:06.939735Z","caller":"traceutil/trace.go:171","msg":"trace[1765295739] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4600; }","duration":"125.328558ms","start":"2026-03-11T17:13:06.814388Z","end":"2026-03-11T17:13:06.939716Z","steps":["trace[1765295739] 'agreement among raft nodes before linearized reading' (duration: 124.994849ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:13:06.939889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.013969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-03-11T17:13:06.939946Z","caller":"traceutil/trace.go:171","msg":"trace[1994161728] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:4600; }","duration":"199.07733ms","start":"2026-03-11T17:13:06.740852Z","end":"2026-03-11T17:13:06.93993Z","steps":["trace[1994161728] 'agreement among raft nodes before linearized reading' (duration: 198.67482ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:13:06.940052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.593978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-03-11T17:13:06.940106Z","caller":"traceutil/trace.go:171","msg":"trace[920773064] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4600; }","duration":"134.696131ms","start":"2026-03-11T17:13:06.805393Z","end":"2026-03-11T17:13:06.940089Z","steps":["trace[920773064] 'agreement among raft nodes before linearized reading' (duration: 134.501245ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:13:25.626942Z","caller":"traceutil/trace.go:171","msg":"trace[33353234] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"118.353548ms","start":"2026-03-11T17:13:25.508513Z","end":"2026-03-11T17:13:25.626866Z","steps":["trace[33353234] 'process raft request' (duration: 117.987458ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:13:25.728048Z","caller":"traceutil/trace.go:171","msg":"trace[1267742217] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"114.040792ms","start":"2026-03-11T17:13:25.613975Z","end":"2026-03-11T17:13:25.728015Z","steps":["trace[1267742217] 'process raft request' (duration: 113.904428ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:13:25.728349Z","caller":"traceutil/trace.go:171","msg":"trace[1028378050] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"161.267529ms","start":"2026-03-11T17:13:25.567022Z","end":"2026-03-11T17:13:25.728289Z","steps":["trace[1028378050] 'process raft request' (duration: 140.707733ms)","trace[1028378050] 'compare' (duration: 19.945109ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:13:28.692674Z","caller":"traceutil/trace.go:171","msg":"trace[299896713] transaction","detail":"{read_only:false; response_revision:4988; number_of_response:1; }","duration":"123.771775ms","start":"2026-03-11T17:13:28.568874Z","end":"2026-03-11T17:13:28.692646Z","steps":["trace[299896713] 'process raft request' (duration: 123.554799ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:13:28.693101Z","caller":"traceutil/trace.go:171","msg":"trace[1992360484] transaction","detail":"{read_only:false; response_revision:4989; number_of_response:1; }","duration":"123.534338ms","start":"2026-03-11T17:13:28.569534Z","end":"2026-03-11T17:13:28.693069Z","steps":["trace[1992360484] 'process raft request' (duration: 123.051365ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:13:28.693283Z","caller":"traceutil/trace.go:171","msg":"trace[1439245874] transaction","detail":"{read_only:false; response_revision:4990; number_of_response:1; }","duration":"123.510277ms","start":"2026-03-11T17:13:28.569753Z","end":"2026-03-11T17:13:28.693263Z","steps":["trace[1439245874] 'process raft request' (duration: 123.24372ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:13:28.695446Z","caller":"traceutil/trace.go:171","msg":"trace[294050135] transaction","detail":"{read_only:false; response_revision:4991; number_of_response:1; }","duration":"125.522133ms","start":"2026-03-11T17:13:28.569884Z","end":"2026-03-11T17:13:28.695406Z","steps":["trace[294050135] 'process raft request' (duration: 123.23573ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:13:28.695761Z","caller":"traceutil/trace.go:171","msg":"trace[1908735134] transaction","detail":"{read_only:false; response_revision:4992; number_of_response:1; }","duration":"125.704207ms","start":"2026-03-11T17:13:28.570032Z","end":"2026-03-11T17:13:28.695737Z","steps":["trace[1908735134] 'process raft request' (duration: 125.284216ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:13:28.695799Z","caller":"traceutil/trace.go:171","msg":"trace[1113642743] transaction","detail":"{read_only:false; response_revision:4993; number_of_response:1; }","duration":"125.42671ms","start":"2026-03-11T17:13:28.570341Z","end":"2026-03-11T17:13:28.695767Z","steps":["trace[1113642743] 'process raft request' (duration: 125.217805ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:13:38.76306Z","caller":"traceutil/trace.go:171","msg":"trace[637794495] linearizableReadLoop","detail":"{readStateIndex:5326; appliedIndex:5325; }","duration":"107.152266ms","start":"2026-03-11T17:13:38.655883Z","end":"2026-03-11T17:13:38.763036Z","steps":["trace[637794495] 'read index received' (duration: 106.9428ms)","trace[637794495] 'applied index is now lower than readState.Index' (duration: 208.586µs)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:13:38.763151Z","caller":"traceutil/trace.go:171","msg":"trace[1458484822] transaction","detail":"{read_only:false; response_revision:5131; number_of_response:1; }","duration":"119.917651ms","start":"2026-03-11T17:13:38.643194Z","end":"2026-03-11T17:13:38.763111Z","steps":["trace[1458484822] 'process raft request' (duration: 119.686434ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:13:38.763357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.442864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16549"} {"level":"info","ts":"2026-03-11T17:13:38.763453Z","caller":"traceutil/trace.go:171","msg":"trace[1168024693] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5131; }","duration":"107.555327ms","start":"2026-03-11T17:13:38.655876Z","end":"2026-03-11T17:13:38.763431Z","steps":["trace[1168024693] 'agreement among raft nodes before linearized reading' (duration: 107.2864ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:13:38.930365Z","caller":"traceutil/trace.go:171","msg":"trace[1890152777] linearizableReadLoop","detail":"{readStateIndex:5327; appliedIndex:5326; }","duration":"161.206786ms","start":"2026-03-11T17:13:38.769133Z","end":"2026-03-11T17:13:38.93034Z","steps":["trace[1890152777] 'read index received' (duration: 123.506658ms)","trace[1890152777] 'applied index is now lower than readState.Index' (duration: 37.699178ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:13:38.930509Z","caller":"traceutil/trace.go:171","msg":"trace[1905856184] transaction","detail":"{read_only:false; response_revision:5132; number_of_response:1; }","duration":"162.260875ms","start":"2026-03-11T17:13:38.768196Z","end":"2026-03-11T17:13:38.930457Z","steps":["trace[1905856184] 'process raft request' (duration: 124.388322ms)","trace[1905856184] 'compare' (duration: 37.662187ms)"],"step_count":2} {"level":"warn","ts":"2026-03-11T17:13:38.930622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.470783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-03-11T17:13:38.930669Z","caller":"traceutil/trace.go:171","msg":"trace[1386856763] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5132; }","duration":"161.564995ms","start":"2026-03-11T17:13:38.769092Z","end":"2026-03-11T17:13:38.930657Z","steps":["trace[1386856763] 'agreement among raft nodes before linearized reading' (duration: 161.38101ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:13:38.935486Z","caller":"traceutil/trace.go:171","msg":"trace[395985670] transaction","detail":"{read_only:false; response_revision:5133; number_of_response:1; }","duration":"158.574856ms","start":"2026-03-11T17:13:38.776878Z","end":"2026-03-11T17:13:38.935453Z","steps":["trace[395985670] 'process raft request' (duration: 158.366011ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:14:16.563168Z","caller":"traceutil/trace.go:171","msg":"trace[1247771950] transaction","detail":"{read_only:false; response_revision:5445; number_of_response:1; }","duration":"111.13757ms","start":"2026-03-11T17:14:16.451989Z","end":"2026-03-11T17:14:16.563127Z","steps":["trace[1247771950] 'process raft request' (duration: 68.65912ms)","trace[1247771950] 'compare' (duration: 42.297106ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:14:26.107773Z","caller":"traceutil/trace.go:171","msg":"trace[367133408] transaction","detail":"{read_only:false; response_revision:5501; number_of_response:1; }","duration":"109.196958ms","start":"2026-03-11T17:14:25.998531Z","end":"2026-03-11T17:14:26.107728Z","steps":["trace[367133408] 'process raft request' (duration: 97.969104ms)","trace[367133408] 'compare' (duration: 11.035499ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:14:55.892627Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2769} {"level":"info","ts":"2026-03-11T17:14:55.953769Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2769,"took":"59.066439ms","hash":2079812897,"current-db-size-bytes":40525824,"current-db-size":"40 MB","current-db-size-in-use-bytes":30859264,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-03-11T17:14:55.953853Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2079812897,"revision":2769,"compact-revision":-1} {"level":"info","ts":"2026-03-11T17:19:37.175975Z","caller":"traceutil/trace.go:171","msg":"trace[798697848] linearizableReadLoop","detail":"{readStateIndex:7937; appliedIndex:7936; }","duration":"228.945113ms","start":"2026-03-11T17:19:36.947006Z","end":"2026-03-11T17:19:37.175951Z","steps":["trace[798697848] 'read index received' (duration: 228.763438ms)","trace[798697848] 'applied index is now lower than readState.Index' (duration: 180.585µs)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:19:37.176118Z","caller":"traceutil/trace.go:171","msg":"trace[2017713604] transaction","detail":"{read_only:false; response_revision:7656; number_of_response:1; }","duration":"356.35655ms","start":"2026-03-11T17:19:36.819748Z","end":"2026-03-11T17:19:37.176105Z","steps":["trace[2017713604] 'process raft request' (duration: 356.040042ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:19:37.176233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-11T17:19:36.819723Z","time spent":"356.421441ms","remote":"127.0.0.1:47088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-11T17:19:37.176439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.574147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-03-11T17:19:37.176531Z","caller":"traceutil/trace.go:171","msg":"trace[2139284919] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7656; }","duration":"186.705681ms","start":"2026-03-11T17:19:36.989805Z","end":"2026-03-11T17:19:37.17651Z","steps":["trace[2139284919] 'agreement among raft nodes before linearized reading' (duration: 186.483085ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:19:37.176681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.675903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-03-11T17:19:37.176683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.540131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12209"} {"level":"info","ts":"2026-03-11T17:19:37.176731Z","caller":"traceutil/trace.go:171","msg":"trace[964593711] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:7656; }","duration":"229.727514ms","start":"2026-03-11T17:19:36.94699Z","end":"2026-03-11T17:19:37.176718Z","steps":["trace[964593711] 'agreement among raft nodes before linearized reading' (duration: 229.644062ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:19:37.176742Z","caller":"traceutil/trace.go:171","msg":"trace[1876284585] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7656; }","duration":"103.650764ms","start":"2026-03-11T17:19:37.073079Z","end":"2026-03-11T17:19:37.176729Z","steps":["trace[1876284585] 'agreement among raft nodes before linearized reading' (duration: 103.434588ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:19:37.176732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.27926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-03-11T17:19:37.176775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.628909ms","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-03-11T17:19:37.176805Z","caller":"traceutil/trace.go:171","msg":"trace[1214695703] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7656; }","duration":"172.429403ms","start":"2026-03-11T17:19:37.004361Z","end":"2026-03-11T17:19:37.17679Z","steps":["trace[1214695703] 'agreement among raft nodes before linearized reading' (duration: 172.177647ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:19:37.176815Z","caller":"traceutil/trace.go:171","msg":"trace[356119695] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7656; }","duration":"179.695591ms","start":"2026-03-11T17:19:36.99711Z","end":"2026-03-11T17:19:37.176805Z","steps":["trace[356119695] 'agreement among raft nodes before linearized reading' (duration: 179.604558ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:19:49.41589Z","caller":"traceutil/trace.go:171","msg":"trace[1057502077] transaction","detail":"{read_only:false; response_revision:7713; number_of_response:1; }","duration":"132.3849ms","start":"2026-03-11T17:19:49.283481Z","end":"2026-03-11T17:19:49.415866Z","steps":["trace[1057502077] 'process raft request' (duration: 132.238907ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:19:49.440195Z","caller":"traceutil/trace.go:171","msg":"trace[613567227] transaction","detail":"{read_only:false; response_revision:7714; number_of_response:1; }","duration":"155.60286ms","start":"2026-03-11T17:19:49.284571Z","end":"2026-03-11T17:19:49.440174Z","steps":["trace[613567227] 'process raft request' (duration: 155.454306ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:19:49.440489Z","caller":"traceutil/trace.go:171","msg":"trace[2040258923] transaction","detail":"{read_only:false; response_revision:7715; number_of_response:1; }","duration":"153.715938ms","start":"2026-03-11T17:19:49.286765Z","end":"2026-03-11T17:19:49.440481Z","steps":["trace[2040258923] 'process raft request' (duration: 153.376299ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:19:49.440587Z","caller":"traceutil/trace.go:171","msg":"trace[1346829383] transaction","detail":"{read_only:false; response_revision:7716; number_of_response:1; }","duration":"115.302458ms","start":"2026-03-11T17:19:49.325277Z","end":"2026-03-11T17:19:49.44058Z","steps":["trace[1346829383] 'process raft request' (duration: 115.060212ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:19:49.440614Z","caller":"traceutil/trace.go:171","msg":"trace[497470899] linearizableReadLoop","detail":"{readStateIndex:8000; appliedIndex:7997; }","duration":"151.897399ms","start":"2026-03-11T17:19:49.288701Z","end":"2026-03-11T17:19:49.440598Z","steps":["trace[497470899] 'read index received' (duration: 127.122748ms)","trace[497470899] 'applied index is now lower than readState.Index' (duration: 24.773671ms)"],"step_count":2} {"level":"warn","ts":"2026-03-11T17:19:49.440863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.143385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-03-11T17:19:49.440912Z","caller":"traceutil/trace.go:171","msg":"trace[1406410291] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7718; }","duration":"152.231938ms","start":"2026-03-11T17:19:49.288668Z","end":"2026-03-11T17:19:49.4409Z","steps":["trace[1406410291] 'agreement among raft nodes before linearized reading' (duration: 152.024742ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:19:55.898983Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5720} {"level":"info","ts":"2026-03-11T17:19:55.981928Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5720,"took":"80.705803ms","hash":1766579383,"current-db-size-bytes":42704896,"current-db-size":"43 MB","current-db-size-in-use-bytes":23343104,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-03-11T17:19:55.981989Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1766579383,"revision":5720,"compact-revision":2769} {"level":"info","ts":"2026-03-11T17:20:29.872976Z","caller":"traceutil/trace.go:171","msg":"trace[960776116] linearizableReadLoop","detail":"{readStateIndex:8309; appliedIndex:8308; }","duration":"122.200076ms","start":"2026-03-11T17:20:29.750748Z","end":"2026-03-11T17:20:29.872948Z","steps":["trace[960776116] 'read index received' (duration: 122.037341ms)","trace[960776116] 'applied index is now lower than readState.Index' (duration: 161.195µs)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:20:29.87326Z","caller":"traceutil/trace.go:171","msg":"trace[861568236] transaction","detail":"{read_only:false; response_revision:8009; number_of_response:1; }","duration":"142.996358ms","start":"2026-03-11T17:20:29.730247Z","end":"2026-03-11T17:20:29.873243Z","steps":["trace[861568236] 'process raft request' (duration: 142.521685ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:20:29.873687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.914575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-03-11T17:20:29.873742Z","caller":"traceutil/trace.go:171","msg":"trace[1402685430] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8009; }","duration":"123.007158ms","start":"2026-03-11T17:20:29.750723Z","end":"2026-03-11T17:20:29.87373Z","steps":["trace[1402685430] 'agreement among raft nodes before linearized reading' (duration: 122.828803ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:20:29.996635Z","caller":"traceutil/trace.go:171","msg":"trace[648963521] linearizableReadLoop","detail":"{readStateIndex:8310; appliedIndex:8309; }","duration":"123.556602ms","start":"2026-03-11T17:20:29.873056Z","end":"2026-03-11T17:20:29.996613Z","steps":["trace[648963521] 'read index received' (duration: 80.508148ms)","trace[648963521] 'applied index is now lower than readState.Index' (duration: 43.047484ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:20:29.996737Z","caller":"traceutil/trace.go:171","msg":"trace[2017831375] transaction","detail":"{read_only:false; response_revision:8010; number_of_response:1; }","duration":"131.260111ms","start":"2026-03-11T17:20:29.865464Z","end":"2026-03-11T17:20:29.996724Z","steps":["trace[2017831375] 'process raft request' (duration: 88.139655ms)","trace[2017831375] 'compare' (duration: 42.90191ms)"],"step_count":2} {"level":"warn","ts":"2026-03-11T17:20:29.996962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.910513ms","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-03-11T17:20:29.997056Z","caller":"traceutil/trace.go:171","msg":"trace[1740487460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8010; }","duration":"232.057097ms","start":"2026-03-11T17:20:29.764981Z","end":"2026-03-11T17:20:29.997039Z","steps":["trace[1740487460] 'agreement among raft nodes before linearized reading' (duration: 231.865602ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:20:29.997086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.653406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-03-11T17:20:29.997132Z","caller":"traceutil/trace.go:171","msg":"trace[568297837] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8010; }","duration":"238.726987ms","start":"2026-03-11T17:20:29.758394Z","end":"2026-03-11T17:20:29.997121Z","steps":["trace[568297837] 'agreement among raft nodes before linearized reading' (duration: 238.585714ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:20:30.015747Z","caller":"traceutil/trace.go:171","msg":"trace[1491572590] transaction","detail":"{read_only:false; response_revision:8011; number_of_response:1; }","duration":"139.122483ms","start":"2026-03-11T17:20:29.876589Z","end":"2026-03-11T17:20:30.015712Z","steps":["trace[1491572590] 'process raft request' (duration: 138.746503ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:20:30.015833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.965928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-11T17:20:30.015887Z","caller":"traceutil/trace.go:171","msg":"trace[798497349] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:8011; }","duration":"112.049101ms","start":"2026-03-11T17:20:29.903824Z","end":"2026-03-11T17:20:30.015873Z","steps":["trace[798497349] 'agreement among raft nodes before linearized reading' (duration: 111.890596ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:20:30.183884Z","caller":"traceutil/trace.go:171","msg":"trace[1243579604] transaction","detail":"{read_only:false; response_revision:8016; number_of_response:1; }","duration":"106.517311ms","start":"2026-03-11T17:20:30.077241Z","end":"2026-03-11T17:20:30.183758Z","steps":["trace[1243579604] 'process raft request' (duration: 106.202103ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:20:30.74563Z","caller":"traceutil/trace.go:171","msg":"trace[271622467] transaction","detail":"{read_only:false; response_revision:8020; number_of_response:1; }","duration":"121.034444ms","start":"2026-03-11T17:20:30.624566Z","end":"2026-03-11T17:20:30.745601Z","steps":["trace[271622467] 'process raft request' (duration: 120.837508ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:20:43.817184Z","caller":"traceutil/trace.go:171","msg":"trace[699073599] linearizableReadLoop","detail":"{readStateIndex:8421; appliedIndex:8420; }","duration":"108.797574ms","start":"2026-03-11T17:20:43.708356Z","end":"2026-03-11T17:20:43.817153Z","steps":["trace[699073599] 'read index received' (duration: 107.551379ms)","trace[699073599] 'applied index is now lower than readState.Index' (duration: 1.244995ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:20:43.817403Z","caller":"traceutil/trace.go:171","msg":"trace[542661409] transaction","detail":"{read_only:false; response_revision:8118; number_of_response:1; }","duration":"167.624544ms","start":"2026-03-11T17:20:43.649744Z","end":"2026-03-11T17:20:43.817368Z","steps":["trace[542661409] 'process raft request' (duration: 166.155884ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:20:43.817437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.245714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-11T17:20:43.817549Z","caller":"traceutil/trace.go:171","msg":"trace[1977042207] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8118; }","duration":"113.396888ms","start":"2026-03-11T17:20:43.704133Z","end":"2026-03-11T17:20:43.81753Z","steps":["trace[1977042207] 'agreement among raft nodes before linearized reading' (duration: 113.190722ms)"],"step_count":1} {"level":"warn","ts":"2026-03-11T17:20:43.81771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.768405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19405"} {"level":"info","ts":"2026-03-11T17:20:43.817767Z","caller":"traceutil/trace.go:171","msg":"trace[1718369877] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:8118; }","duration":"107.976802ms","start":"2026-03-11T17:20:43.709775Z","end":"2026-03-11T17:20:43.817752Z","steps":["trace[1718369877] 'agreement among raft nodes before linearized reading' (duration: 107.55247ms)"],"step_count":1} {"level":"info","ts":"2026-03-11T17:21:31.993195Z","caller":"traceutil/trace.go:171","msg":"trace[424798346] transaction","detail":"{read_only:false; response_revision:8642; number_of_response:1; }","duration":"110.653084ms","start":"2026-03-11T17:21:31.882501Z","end":"2026-03-11T17:21:31.993154Z","steps":["trace[424798346] 'process raft request' (duration: 81.548036ms)","trace[424798346] 'compare' (duration: 28.592934ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:21:44.422199Z","caller":"traceutil/trace.go:171","msg":"trace[264065350] transaction","detail":"{read_only:false; response_revision:8711; number_of_response:1; }","duration":"175.836289ms","start":"2026-03-11T17:21:44.246326Z","end":"2026-03-11T17:21:44.422162Z","steps":["trace[264065350] 'process raft request' (duration: 130.740799ms)","trace[264065350] 'compare' (duration: 44.599657ms)"],"step_count":2} {"level":"info","ts":"2026-03-11T17:23:59.08658Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d0ba3c4de8c6ef7a","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-11T17:23:59.095295Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-11T17:23:59.095476Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-11T17:24:55.906452Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7755} {"level":"info","ts":"2026-03-11T17:24:55.978196Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7755,"took":"68.727863ms","hash":2760946056,"current-db-size-bytes":42704896,"current-db-size":"43 MB","current-db-size-in-use-bytes":26288128,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-03-11T17:24:55.978272Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2760946056,"revision":7755,"compact-revision":5720} {"level":"info","ts":"2026-03-11T17:29:55.912281Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9995} {"level":"info","ts":"2026-03-11T17:29:55.988631Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9995,"took":"74.312218ms","hash":491693272,"current-db-size-bytes":42704896,"current-db-size":"43 MB","current-db-size-in-use-bytes":17584128,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-03-11T17:29:55.988695Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":491693272,"revision":9995,"compact-revision":7755}