{"level":"warn","ts":"2026-07-16T00:17:50.98165Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-16T00:17:50.981778Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38: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.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-16T00:17:50.981842Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-16T00:17:50.98185Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-07-16T00:17:50.981878Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-16T00:17:50.982496Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-07-16T00:17:50.982562Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-16T00:17:50.989758Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.016679ms"} {"level":"info","ts":"2026-07-16T00:17:50.998742Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-07-16T00:17:50.998819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-07-16T00:17:50.998843Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-07-16T00:17:50.998861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-16T00:17:50.998877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-07-16T00:17:50.998921Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-07-16T00:17:51.011609Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-16T00:17:51.013147Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-16T00:17:51.014228Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-16T00:17:51.016491Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-16T00:17:51.016971Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-16T00:17:51.017053Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-16T00:17:51.017089Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-16T00:17:51.017096Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-16T00:17:51.021052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-07-16T00:17:51.021215Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-07-16T00:17:51.022654Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-16T00:17:51.022772Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-07-16T00:17:51.022784Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-07-16T00:17:51.022998Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-16T00:17:51.023057Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-16T00:17:51.999437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-07-16T00:17:51.999532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-16T00:17:51.999601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-07-16T00:17:51.999637Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-07-16T00:17:51.99965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-07-16T00:17:51.999672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-07-16T00:17:51.999697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-07-16T00:17:52.000837Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-16T00:17:52.000838Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T00:17:52.001109Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-16T00:17:52.000835Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-07-16T00:17:52.001579Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-16T00:17:52.001611Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-16T00:17:52.002018Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T00:17:52.002123Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T00:17:52.002154Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T00:17:52.00444Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-07-16T00:17:52.004516Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-16T00:18:26.961351Z","caller":"traceutil/trace.go:171","msg":"trace[1349358109] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"166.910602ms","start":"2026-07-16T00:18:26.794402Z","end":"2026-07-16T00:18:26.961313Z","steps":["trace[1349358109] 'process raft request' (duration: 166.725458ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:27.596941Z","caller":"traceutil/trace.go:171","msg":"trace[1540227836] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"124.357757ms","start":"2026-07-16T00:18:27.472549Z","end":"2026-07-16T00:18:27.596907Z","steps":["trace[1540227836] 'process raft request' (duration: 50.946398ms)","trace[1540227836] 'compare' (duration: 73.262837ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:18:27.619296Z","caller":"traceutil/trace.go:171","msg":"trace[1001723327] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"125.084553ms","start":"2026-07-16T00:18:27.494169Z","end":"2026-07-16T00:18:27.619253Z","steps":["trace[1001723327] 'process raft request' (duration: 124.995636ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:27.619822Z","caller":"traceutil/trace.go:171","msg":"trace[597993970] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"147.099378ms","start":"2026-07-16T00:18:27.472706Z","end":"2026-07-16T00:18:27.619806Z","steps":["trace[597993970] 'process raft request' (duration: 146.20728ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:27.890635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.474614ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T00:18:27.890979Z","caller":"traceutil/trace.go:171","msg":"trace[933932541] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"265.256564ms","start":"2026-07-16T00:18:27.625638Z","end":"2026-07-16T00:18:27.890895Z","steps":["trace[933932541] 'process raft request' (duration: 154.533415ms)","trace[933932541] 'compare' (duration: 109.337003ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:18:27.894804Z","caller":"traceutil/trace.go:171","msg":"trace[634266181] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:542; }","duration":"127.665189ms","start":"2026-07-16T00:18:27.767117Z","end":"2026-07-16T00:18:27.894782Z","steps":["trace[634266181] 'read index received' (duration: 13.039822ms)","trace[634266181] 'applied index is now lower than readState.Index' (duration: 114.624617ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:18:27.894853Z","caller":"traceutil/trace.go:171","msg":"trace[400613707] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"210.718172ms","start":"2026-07-16T00:18:27.684096Z","end":"2026-07-16T00:18:27.894814Z","steps":["trace[400613707] 'process raft request' (duration: 210.482255ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:27.894981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.042427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-16T00:18:27.895012Z","caller":"traceutil/trace.go:171","msg":"trace[402489421] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:528; }","duration":"128.125604ms","start":"2026-07-16T00:18:27.76688Z","end":"2026-07-16T00:18:27.895005Z","steps":["trace[402489421] 'agreement among raft nodes before linearized reading' (duration: 128.048558ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:27.895062Z","caller":"traceutil/trace.go:171","msg":"trace[105121437] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"253.376409ms","start":"2026-07-16T00:18:27.641675Z","end":"2026-07-16T00:18:27.895051Z","steps":["trace[105121437] 'process raft request' (duration: 252.782184ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:27.894916Z","caller":"traceutil/trace.go:171","msg":"trace[618026878] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"210.699451ms","start":"2026-07-16T00:18:27.684208Z","end":"2026-07-16T00:18:27.894908Z","steps":["trace[618026878] 'process raft request' (duration: 210.488385ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:27.895297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.283957ms","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-07-16T00:18:27.895342Z","caller":"traceutil/trace.go:171","msg":"trace[750789266] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:528; }","duration":"125.386115ms","start":"2026-07-16T00:18:27.769946Z","end":"2026-07-16T00:18:27.895332Z","steps":["trace[750789266] 'agreement among raft nodes before linearized reading' (duration: 125.289017ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:29.059931Z","caller":"traceutil/trace.go:171","msg":"trace[1319611229] linearizableReadLoop","detail":"{readStateIndex:577; appliedIndex:576; }","duration":"108.390787ms","start":"2026-07-16T00:18:28.951485Z","end":"2026-07-16T00:18:29.059876Z","steps":["trace[1319611229] 'read index received' (duration: 75.372768ms)","trace[1319611229] 'applied index is now lower than readState.Index' (duration: 33.017189ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:18:29.060036Z","caller":"traceutil/trace.go:171","msg":"trace[1182869525] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"121.056562ms","start":"2026-07-16T00:18:28.938935Z","end":"2026-07-16T00:18:29.059991Z","steps":["trace[1182869525] 'process raft request' (duration: 88.897439ms)","trace[1182869525] 'compare' (duration: 31.342021ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:18:29.060187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.674818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-07-16T00:18:29.06025Z","caller":"traceutil/trace.go:171","msg":"trace[1539100925] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:559; }","duration":"108.769545ms","start":"2026-07-16T00:18:28.951465Z","end":"2026-07-16T00:18:29.060235Z","steps":["trace[1539100925] 'agreement among raft nodes before linearized reading' (duration: 108.545608ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:33.166347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.424063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T00:18:33.16641Z","caller":"traceutil/trace.go:171","msg":"trace[683299770] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"148.527666ms","start":"2026-07-16T00:18:33.017868Z","end":"2026-07-16T00:18:33.166396Z","steps":["trace[683299770] 'range keys from in-memory index tree' (duration: 148.365057ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:33.2994Z","caller":"traceutil/trace.go:171","msg":"trace[214240412] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"126.788177ms","start":"2026-07-16T00:18:33.172585Z","end":"2026-07-16T00:18:33.299373Z","steps":["trace[214240412] 'process raft request' (duration: 114.67573ms)","trace[214240412] 'compare' (duration: 12.034242ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:18:33.773774Z","caller":"traceutil/trace.go:171","msg":"trace[171615203] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"370.535259ms","start":"2026-07-16T00:18:33.403202Z","end":"2026-07-16T00:18:33.773737Z","steps":["trace[171615203] 'process raft request' (duration: 369.855632ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:18:33.773981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:18:33.403144Z","time spent":"370.730346ms","remote":"127.0.0.1:54280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036253,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T00:18:47.56651Z","caller":"traceutil/trace.go:171","msg":"trace[1938853712] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"211.072498ms","start":"2026-07-16T00:18:47.355409Z","end":"2026-07-16T00:18:47.566481Z","steps":["trace[1938853712] 'process raft request' (duration: 210.913754ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:47.63185Z","caller":"traceutil/trace.go:171","msg":"trace[678641506] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"276.108075ms","start":"2026-07-16T00:18:47.355715Z","end":"2026-07-16T00:18:47.631823Z","steps":["trace[678641506] 'process raft request' (duration: 273.486315ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:47.631904Z","caller":"traceutil/trace.go:171","msg":"trace[340844909] linearizableReadLoop","detail":"{readStateIndex:768; appliedIndex:767; }","duration":"274.978299ms","start":"2026-07-16T00:18:47.356906Z","end":"2026-07-16T00:18:47.631884Z","steps":["trace[340844909] 'read index received' (duration: 209.555025ms)","trace[340844909] 'applied index is now lower than readState.Index' (duration: 65.422154ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:18:47.632062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.133823ms","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-07-16T00:18:47.632093Z","caller":"traceutil/trace.go:171","msg":"trace[1606503012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:746; }","duration":"275.19846ms","start":"2026-07-16T00:18:47.356886Z","end":"2026-07-16T00:18:47.632084Z","steps":["trace[1606503012] 'agreement among raft nodes before linearized reading' (duration: 275.059255ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:18:47.632154Z","caller":"traceutil/trace.go:171","msg":"trace[1970583047] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"155.641541ms","start":"2026-07-16T00:18:47.476482Z","end":"2026-07-16T00:18:47.632124Z","steps":["trace[1970583047] 'process raft request' (duration: 155.274235ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:19:40.432548Z","caller":"traceutil/trace.go:171","msg":"trace[1088819638] transaction","detail":"{read_only:false; response_revision:1410; number_of_response:1; }","duration":"138.990105ms","start":"2026-07-16T00:19:40.293235Z","end":"2026-07-16T00:19:40.432225Z","steps":["trace[1088819638] 'process raft request' (duration: 138.764761ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:19:40.439031Z","caller":"traceutil/trace.go:171","msg":"trace[1999962241] linearizableReadLoop","detail":"{readStateIndex:1452; appliedIndex:1450; }","duration":"131.562424ms","start":"2026-07-16T00:19:40.307437Z","end":"2026-07-16T00:19:40.438999Z","steps":["trace[1999962241] 'read index received' (duration: 124.595853ms)","trace[1999962241] 'applied index is now lower than readState.Index' (duration: 6.965301ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:19:40.439089Z","caller":"traceutil/trace.go:171","msg":"trace[935759684] transaction","detail":"{read_only:false; response_revision:1411; number_of_response:1; }","duration":"144.6047ms","start":"2026-07-16T00:19:40.294443Z","end":"2026-07-16T00:19:40.439048Z","steps":["trace[935759684] 'process raft request' (duration: 144.389946ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:19:40.439273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.822949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-07-16T00:19:40.439352Z","caller":"traceutil/trace.go:171","msg":"trace[314624817] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1411; }","duration":"131.965261ms","start":"2026-07-16T00:19:40.307367Z","end":"2026-07-16T00:19:40.439332Z","steps":["trace[314624817] 'agreement among raft nodes before linearized reading' (duration: 131.747707ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:20:04.362664Z","caller":"traceutil/trace.go:171","msg":"trace[1847350792] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"257.16186ms","start":"2026-07-16T00:20:04.105465Z","end":"2026-07-16T00:20:04.362627Z","steps":["trace[1847350792] 'process raft request' (duration: 256.930073ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:20:04.369634Z","caller":"traceutil/trace.go:171","msg":"trace[139560305] transaction","detail":"{read_only:false; response_revision:1811; number_of_response:1; }","duration":"262.474143ms","start":"2026-07-16T00:20:04.107137Z","end":"2026-07-16T00:20:04.369611Z","steps":["trace[139560305] 'process raft request' (duration: 262.35585ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:04.81777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.422879ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-16T00:20:04.818088Z","caller":"traceutil/trace.go:171","msg":"trace[1166456891] transaction","detail":"{read_only:false; response_revision:1812; number_of_response:1; }","duration":"441.580257ms","start":"2026-07-16T00:20:04.376442Z","end":"2026-07-16T00:20:04.818023Z","steps":["trace[1166456891] 'process raft request' (duration: 139.806187ms)","trace[1166456891] 'compare' (duration: 301.228742ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:20:04.818122Z","caller":"traceutil/trace.go:171","msg":"trace[1498134416] linearizableReadLoop","detail":"{readStateIndex:1879; appliedIndex:1878; }","duration":"437.859397ms","start":"2026-07-16T00:20:04.380233Z","end":"2026-07-16T00:20:04.818093Z","steps":["trace[1498134416] 'read index received' (duration: 136.007214ms)","trace[1498134416] 'applied index is now lower than readState.Index' (duration: 301.848463ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:20:04.818225Z","caller":"traceutil/trace.go:171","msg":"trace[193776279] transaction","detail":"{read_only:false; response_revision:1813; number_of_response:1; }","duration":"235.674796ms","start":"2026-07-16T00:20:04.582486Z","end":"2026-07-16T00:20:04.818161Z","steps":["trace[193776279] 'process raft request' (duration: 235.463899ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:04.818299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:04.376429Z","time spent":"441.750664ms","remote":"127.0.0.1:54370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T00:20:04.818316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.061033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-de5f3373-46d0-49e9-bd8f-8af89a855358\" ","response":"range_response_count:1 size:3746"} {"level":"info","ts":"2026-07-16T00:20:04.818374Z","caller":"traceutil/trace.go:171","msg":"trace[1927420401] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-de5f3373-46d0-49e9-bd8f-8af89a855358; range_end:; response_count:1; response_revision:1813; }","duration":"438.134935ms","start":"2026-07-16T00:20:04.380222Z","end":"2026-07-16T00:20:04.818357Z","steps":["trace[1927420401] 'agreement among raft nodes before linearized reading' (duration: 437.96373ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:04.818417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:04.380205Z","time spent":"438.202507ms","remote":"127.0.0.1:54370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3768,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-de5f3373-46d0-49e9-bd8f-8af89a855358\" "} {"level":"warn","ts":"2026-07-16T00:20:04.819646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.682918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T00:20:04.819966Z","caller":"traceutil/trace.go:171","msg":"trace[1642299088] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1814; }","duration":"153.03055ms","start":"2026-07-16T00:20:04.666924Z","end":"2026-07-16T00:20:04.819955Z","steps":["trace[1642299088] 'agreement among raft nodes before linearized reading' (duration: 152.680689ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:04.819758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.412388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-16T00:20:04.820232Z","caller":"traceutil/trace.go:171","msg":"trace[142619627] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1814; }","duration":"239.927034ms","start":"2026-07-16T00:20:04.580288Z","end":"2026-07-16T00:20:04.820215Z","steps":["trace[142619627] 'agreement among raft nodes before linearized reading' (duration: 239.196601ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:04.82055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.203389ms","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-07-16T00:20:04.820593Z","caller":"traceutil/trace.go:171","msg":"trace[15162854] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1814; }","duration":"234.26806ms","start":"2026-07-16T00:20:04.586314Z","end":"2026-07-16T00:20:04.820582Z","steps":["trace[15162854] 'agreement among raft nodes before linearized reading' (duration: 234.151815ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:20:15.84444Z","caller":"traceutil/trace.go:171","msg":"trace[1287558747] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"117.745737ms","start":"2026-07-16T00:20:15.726628Z","end":"2026-07-16T00:20:15.844374Z","steps":["trace[1287558747] 'process raft request' (duration: 117.568231ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:20:32.514368Z","caller":"traceutil/trace.go:171","msg":"trace[138665861] linearizableReadLoop","detail":"{readStateIndex:2091; appliedIndex:2090; }","duration":"500.147696ms","start":"2026-07-16T00:20:32.014196Z","end":"2026-07-16T00:20:32.514343Z","steps":["trace[138665861] 'read index received' (duration: 500.024531ms)","trace[138665861] 'applied index is now lower than readState.Index' (duration: 122.145µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:20:32.51442Z","caller":"traceutil/trace.go:171","msg":"trace[1025042836] transaction","detail":"{read_only:false; response_revision:2017; number_of_response:1; }","duration":"607.294142ms","start":"2026-07-16T00:20:31.90709Z","end":"2026-07-16T00:20:32.514384Z","steps":["trace[1025042836] 'process raft request' (duration: 607.087473ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:32.514645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.414967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-16T00:20:32.514718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.231012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-16T00:20:32.514745Z","caller":"traceutil/trace.go:171","msg":"trace[152349926] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2017; }","duration":"500.591506ms","start":"2026-07-16T00:20:32.014128Z","end":"2026-07-16T00:20:32.51472Z","steps":["trace[152349926] 'agreement among raft nodes before linearized reading' (duration: 500.348775ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:32.514739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:31.907057Z","time spent":"607.445228ms","remote":"127.0.0.1:54458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T00:20:32.514791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:32.014104Z","time spent":"500.678749ms","remote":"127.0.0.1:54186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-16T00:20:32.51481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.16343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T00:20:32.514916Z","caller":"traceutil/trace.go:171","msg":"trace[461214119] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2017; }","duration":"428.308826ms","start":"2026-07-16T00:20:32.086585Z","end":"2026-07-16T00:20:32.514893Z","steps":["trace[461214119] 'agreement among raft nodes before linearized reading' (duration: 428.135079ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:32.514958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:32.08657Z","time spent":"428.378808ms","remote":"127.0.0.1:42554","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-07-16T00:20:32.514823Z","caller":"traceutil/trace.go:171","msg":"trace[487900913] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2017; }","duration":"489.351537ms","start":"2026-07-16T00:20:32.025406Z","end":"2026-07-16T00:20:32.514757Z","steps":["trace[487900913] 'agreement among raft nodes before linearized reading' (duration: 489.163709ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:32.515035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:32.025381Z","time spent":"489.626979ms","remote":"127.0.0.1:58920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-07-16T00:20:32.515289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.437749ms","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-07-16T00:20:32.515388Z","caller":"traceutil/trace.go:171","msg":"trace[628482649] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2017; }","duration":"384.578817ms","start":"2026-07-16T00:20:32.130792Z","end":"2026-07-16T00:20:32.515371Z","steps":["trace[628482649] 'agreement among raft nodes before linearized reading' (duration: 383.836874ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:32.515486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:20:32.13077Z","time spent":"384.703242ms","remote":"127.0.0.1:54458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-16T00:20:33.071466Z","caller":"traceutil/trace.go:171","msg":"trace[1232027522] transaction","detail":"{read_only:false; response_revision:2022; number_of_response:1; }","duration":"109.009785ms","start":"2026-07-16T00:20:32.962436Z","end":"2026-07-16T00:20:33.071446Z","steps":["trace[1232027522] 'process raft request' (duration: 108.8897ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:20:33.162057Z","caller":"traceutil/trace.go:171","msg":"trace[1643288780] linearizableReadLoop","detail":"{readStateIndex:2097; appliedIndex:2095; }","duration":"188.443133ms","start":"2026-07-16T00:20:32.97359Z","end":"2026-07-16T00:20:33.162034Z","steps":["trace[1643288780] 'read index received' (duration: 97.673643ms)","trace[1643288780] 'applied index is now lower than readState.Index' (duration: 90.76829ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:20:33.162103Z","caller":"traceutil/trace.go:171","msg":"trace[1104107703] transaction","detail":"{read_only:false; response_revision:2023; number_of_response:1; }","duration":"198.670128ms","start":"2026-07-16T00:20:32.963397Z","end":"2026-07-16T00:20:33.162067Z","steps":["trace[1104107703] 'process raft request' (duration: 194.486055ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:20:33.162371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.761117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-16T00:20:33.162401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.77175ms","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-07-16T00:20:33.162443Z","caller":"traceutil/trace.go:171","msg":"trace[1167361116] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2023; }","duration":"188.875143ms","start":"2026-07-16T00:20:32.973555Z","end":"2026-07-16T00:20:33.16243Z","steps":["trace[1167361116] 'agreement among raft nodes before linearized reading' (duration: 188.626911ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:20:33.162502Z","caller":"traceutil/trace.go:171","msg":"trace[1455138714] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2023; }","duration":"177.920797ms","start":"2026-07-16T00:20:32.984557Z","end":"2026-07-16T00:20:33.162478Z","steps":["trace[1455138714] 'agreement among raft nodes before linearized reading' (duration: 177.650704ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:21:53.55916Z","caller":"traceutil/trace.go:171","msg":"trace[880353224] linearizableReadLoop","detail":"{readStateIndex:2647; appliedIndex:2646; }","duration":"105.319931ms","start":"2026-07-16T00:21:53.453802Z","end":"2026-07-16T00:21:53.559122Z","steps":["trace[880353224] 'read index received' (duration: 105.044336ms)","trace[880353224] 'applied index is now lower than readState.Index' (duration: 274.585µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:21:53.559544Z","caller":"traceutil/trace.go:171","msg":"trace[1699233248] transaction","detail":"{read_only:false; response_revision:2555; number_of_response:1; }","duration":"175.947863ms","start":"2026-07-16T00:21:53.383583Z","end":"2026-07-16T00:21:53.559531Z","steps":["trace[1699233248] 'process raft request' (duration: 175.353139ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:21:53.559911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.083015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-07-16T00:21:53.559948Z","caller":"traceutil/trace.go:171","msg":"trace[667389626] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2555; }","duration":"106.17514ms","start":"2026-07-16T00:21:53.453762Z","end":"2026-07-16T00:21:53.559938Z","steps":["trace[667389626] 'agreement among raft nodes before linearized reading' (duration: 106.0061ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:21:53.560329Z","caller":"traceutil/trace.go:171","msg":"trace[2042661567] transaction","detail":"{read_only:false; response_revision:2556; number_of_response:1; }","duration":"102.996368ms","start":"2026-07-16T00:21:53.45732Z","end":"2026-07-16T00:21:53.560316Z","steps":["trace[2042661567] 'process raft request' (duration: 102.587695ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:26:13.611531Z","caller":"traceutil/trace.go:171","msg":"trace[1913557187] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4555; }","duration":"118.508363ms","start":"2026-07-16T00:26:13.492978Z","end":"2026-07-16T00:26:13.611487Z","steps":["trace[1913557187] 'process raft request' (duration: 91.146416ms)","trace[1913557187] 'compare' (duration: 27.209052ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:26:22.778974Z","caller":"traceutil/trace.go:171","msg":"trace[1378243793] transaction","detail":"{read_only:false; response_revision:4744; number_of_response:1; }","duration":"126.635337ms","start":"2026-07-16T00:26:22.652312Z","end":"2026-07-16T00:26:22.778948Z","steps":["trace[1378243793] 'process raft request' (duration: 126.351647ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:26:22.779078Z","caller":"traceutil/trace.go:171","msg":"trace[1530417472] transaction","detail":"{read_only:false; response_revision:4742; number_of_response:1; }","duration":"129.96439ms","start":"2026-07-16T00:26:22.6491Z","end":"2026-07-16T00:26:22.779064Z","steps":["trace[1530417472] 'process raft request' (duration: 65.277917ms)","trace[1530417472] 'compare' (duration: 63.934825ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:26:22.779089Z","caller":"traceutil/trace.go:171","msg":"trace[985492167] linearizableReadLoop","detail":"{readStateIndex:4921; appliedIndex:4917; }","duration":"122.404691ms","start":"2026-07-16T00:26:22.656655Z","end":"2026-07-16T00:26:22.77906Z","steps":["trace[985492167] 'read index received' (duration: 3.25554ms)","trace[985492167] 'applied index is now lower than readState.Index' (duration: 119.143941ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:26:22.779159Z","caller":"traceutil/trace.go:171","msg":"trace[753427081] transaction","detail":"{read_only:false; response_revision:4743; number_of_response:1; }","duration":"126.952979ms","start":"2026-07-16T00:26:22.652201Z","end":"2026-07-16T00:26:22.779154Z","steps":["trace[753427081] 'process raft request' (duration: 126.361947ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:26:22.779334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.553846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" ","response":"range_response_count:1 size:1265"} {"level":"info","ts":"2026-07-16T00:26:22.779356Z","caller":"traceutil/trace.go:171","msg":"trace[210811770] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone-nodes; range_end:; response_count:1; response_revision:4745; }","duration":"122.605929ms","start":"2026-07-16T00:26:22.656744Z","end":"2026-07-16T00:26:22.77935Z","steps":["trace[210811770] 'agreement among raft nodes before linearized reading' (duration: 122.454343ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:26:22.77942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.891052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4848"} {"level":"warn","ts":"2026-07-16T00:26:22.779426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.728233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9573"} {"level":"info","ts":"2026-07-16T00:26:22.779514Z","caller":"traceutil/trace.go:171","msg":"trace[1908173299] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4745; }","duration":"119.006536ms","start":"2026-07-16T00:26:22.660485Z","end":"2026-07-16T00:26:22.779492Z","steps":["trace[1908173299] 'agreement among raft nodes before linearized reading' (duration: 118.782568ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:26:22.779525Z","caller":"traceutil/trace.go:171","msg":"trace[642470953] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4745; }","duration":"122.879098ms","start":"2026-07-16T00:26:22.656622Z","end":"2026-07-16T00:26:22.779501Z","steps":["trace[642470953] 'agreement among raft nodes before linearized reading' (duration: 122.541656ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:26:22.780121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.68631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206966"} {"level":"info","ts":"2026-07-16T00:26:22.780176Z","caller":"traceutil/trace.go:171","msg":"trace[492077331] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4745; }","duration":"100.777424ms","start":"2026-07-16T00:26:22.679386Z","end":"2026-07-16T00:26:22.780163Z","steps":["trace[492077331] 'agreement among raft nodes before linearized reading' (duration: 99.841689ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:26:23.102915Z","caller":"traceutil/trace.go:171","msg":"trace[72075041] transaction","detail":"{read_only:false; response_revision:4747; number_of_response:1; }","duration":"304.44428ms","start":"2026-07-16T00:26:22.79842Z","end":"2026-07-16T00:26:23.102864Z","steps":["trace[72075041] 'process raft request' (duration: 292.189428ms)","trace[72075041] 'compare' (duration: 11.781635ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:26:23.1031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:22.798401Z","time spent":"304.609607ms","remote":"127.0.0.1:54644","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9622,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T00:26:23.11532Z","caller":"traceutil/trace.go:171","msg":"trace[425429056] linearizableReadLoop","detail":"{readStateIndex:4926; appliedIndex:4923; }","duration":"298.540815ms","start":"2026-07-16T00:26:22.816747Z","end":"2026-07-16T00:26:23.115288Z","steps":["trace[425429056] 'read index received' (duration: 273.881343ms)","trace[425429056] 'applied index is now lower than readState.Index' (duration: 24.658052ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:26:23.115467Z","caller":"traceutil/trace.go:171","msg":"trace[1064310917] transaction","detail":"{read_only:false; response_revision:4749; number_of_response:1; }","duration":"310.08249ms","start":"2026-07-16T00:26:22.80537Z","end":"2026-07-16T00:26:23.115452Z","steps":["trace[1064310917] 'process raft request' (duration: 309.853082ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:26:23.115591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:22.80534Z","time spent":"310.169313ms","remote":"127.0.0.1:54262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":725,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-16T00:26:23.115658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.800205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-07-16T00:26:23.1157Z","caller":"traceutil/trace.go:171","msg":"trace[1198522806] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4749; }","duration":"298.870278ms","start":"2026-07-16T00:26:22.816818Z","end":"2026-07-16T00:26:23.115688Z","steps":["trace[1198522806] 'agreement among raft nodes before linearized reading' (duration: 298.690031ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:26:23.11545Z","caller":"traceutil/trace.go:171","msg":"trace[148126651] transaction","detail":"{read_only:false; response_revision:4748; number_of_response:1; }","duration":"313.074861ms","start":"2026-07-16T00:26:22.802347Z","end":"2026-07-16T00:26:23.115421Z","steps":["trace[148126651] 'process raft request' (duration: 312.727949ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:26:23.115897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.827522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-07-16T00:26:23.115905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:22.802329Z","time spent":"313.522558ms","remote":"127.0.0.1:54370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3630,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T00:26:23.115925Z","caller":"traceutil/trace.go:171","msg":"trace[1356669097] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4749; }","duration":"169.868463ms","start":"2026-07-16T00:26:22.946049Z","end":"2026-07-16T00:26:23.115917Z","steps":["trace[1356669097] 'agreement among raft nodes before linearized reading' (duration: 169.796551ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:26:23.116047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.297824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9637"} {"level":"warn","ts":"2026-07-16T00:26:23.116067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.414309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-16T00:26:23.116086Z","caller":"traceutil/trace.go:171","msg":"trace[224831409] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4749; }","duration":"175.502851ms","start":"2026-07-16T00:26:22.940578Z","end":"2026-07-16T00:26:23.116081Z","steps":["trace[224831409] 'agreement among raft nodes before linearized reading' (duration: 175.446489ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:26:23.116093Z","caller":"traceutil/trace.go:171","msg":"trace[1637778489] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4749; }","duration":"299.373246ms","start":"2026-07-16T00:26:22.816706Z","end":"2026-07-16T00:26:23.116079Z","steps":["trace[1637778489] 'agreement among raft nodes before linearized reading' (duration: 299.267202ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:26:23.116202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.328118ms","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-07-16T00:26:23.116225Z","caller":"traceutil/trace.go:171","msg":"trace[5216130] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4749; }","duration":"177.40627ms","start":"2026-07-16T00:26:22.938813Z","end":"2026-07-16T00:26:23.11622Z","steps":["trace[5216130] 'agreement among raft nodes before linearized reading' (duration: 177.340248ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:26:23.116277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.102754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T00:26:23.116343Z","caller":"traceutil/trace.go:171","msg":"trace[72632600] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4749; }","duration":"102.209409ms","start":"2026-07-16T00:26:23.014121Z","end":"2026-07-16T00:26:23.116331Z","steps":["trace[72632600] 'agreement among raft nodes before linearized reading' (duration: 102.120935ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:26:23.117629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.916262ms","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-07-16T00:26:23.117776Z","caller":"traceutil/trace.go:171","msg":"trace[550509396] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4749; }","duration":"127.121259ms","start":"2026-07-16T00:26:22.990643Z","end":"2026-07-16T00:26:23.117764Z","steps":["trace[550509396] 'agreement among raft nodes before linearized reading' (duration: 124.98706ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:26:23.477122Z","caller":"traceutil/trace.go:171","msg":"trace[269036382] transaction","detail":"{read_only:false; response_revision:4756; number_of_response:1; }","duration":"227.297954ms","start":"2026-07-16T00:26:23.249763Z","end":"2026-07-16T00:26:23.477061Z","steps":["trace[269036382] 'process raft request' (duration: 225.388993ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:26:23.477345Z","caller":"traceutil/trace.go:171","msg":"trace[1888681048] linearizableReadLoop","detail":"{readStateIndex:4933; appliedIndex:4932; }","duration":"226.834407ms","start":"2026-07-16T00:26:23.249998Z","end":"2026-07-16T00:26:23.476832Z","steps":["trace[1888681048] 'read index received' (duration: 225.150524ms)","trace[1888681048] 'applied index is now lower than readState.Index' (duration: 1.682753ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:26:23.477468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.447749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61382"} {"level":"info","ts":"2026-07-16T00:26:23.477548Z","caller":"traceutil/trace.go:171","msg":"trace[1421963266] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4756; }","duration":"227.534162ms","start":"2026-07-16T00:26:23.249991Z","end":"2026-07-16T00:26:23.477526Z","steps":["trace[1421963266] 'agreement among raft nodes before linearized reading' (duration: 227.296353ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:26:23.479513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.773137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-5c7f8894fb-75jv7.18c29d8198bbb0a8\" ","response":"range_response_count:1 size:898"} {"level":"warn","ts":"2026-07-16T00:26:23.479477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.368749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16231"} {"level":"info","ts":"2026-07-16T00:26:23.479603Z","caller":"traceutil/trace.go:171","msg":"trace[5868463] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4756; }","duration":"137.538745ms","start":"2026-07-16T00:26:23.342056Z","end":"2026-07-16T00:26:23.479595Z","steps":["trace[5868463] 'agreement among raft nodes before linearized reading' (duration: 137.13048ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:26:23.479565Z","caller":"traceutil/trace.go:171","msg":"trace[1919434412] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-5c7f8894fb-75jv7.18c29d8198bbb0a8; range_end:; response_count:1; response_revision:4756; }","duration":"136.964714ms","start":"2026-07-16T00:26:23.342586Z","end":"2026-07-16T00:26:23.47955Z","steps":["trace[1919434412] 'agreement among raft nodes before linearized reading' (duration: 135.072294ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:26:26.506944Z","caller":"traceutil/trace.go:171","msg":"trace[1344554139] transaction","detail":"{read_only:false; response_revision:4796; number_of_response:1; }","duration":"111.055826ms","start":"2026-07-16T00:26:26.395851Z","end":"2026-07-16T00:26:26.506907Z","steps":["trace[1344554139] 'process raft request' (duration: 110.916221ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:26:34.940876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.933434ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-16T00:26:34.942503Z","caller":"traceutil/trace.go:171","msg":"trace[575201902] transaction","detail":"{read_only:false; response_revision:4919; number_of_response:1; }","duration":"248.044256ms","start":"2026-07-16T00:26:34.69443Z","end":"2026-07-16T00:26:34.942474Z","steps":["trace[575201902] 'process raft request' (duration: 247.985944ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T00:26:34.942831Z","caller":"traceutil/trace.go:171","msg":"trace[1712655607] transaction","detail":"{read_only:false; response_revision:4918; number_of_response:1; }","duration":"255.087005ms","start":"2026-07-16T00:26:34.687716Z","end":"2026-07-16T00:26:34.942803Z","steps":["trace[1712655607] 'process raft request' (duration: 254.581316ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:26:34.943102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.246008ms","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-07-16T00:26:34.942628Z","caller":"traceutil/trace.go:171","msg":"trace[98114218] transaction","detail":"{read_only:false; response_revision:4917; number_of_response:1; }","duration":"368.764422ms","start":"2026-07-16T00:26:34.573841Z","end":"2026-07-16T00:26:34.942605Z","steps":["trace[98114218] 'process raft request' (duration: 368.234991ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:26:34.943312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:34.573828Z","time spent":"369.366086ms","remote":"127.0.0.1:54458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T00:26:34.942713Z","caller":"traceutil/trace.go:171","msg":"trace[1875347090] transaction","detail":"{read_only:false; response_revision:4916; number_of_response:1; }","duration":"372.420061ms","start":"2026-07-16T00:26:34.570241Z","end":"2026-07-16T00:26:34.942661Z","steps":["trace[1875347090] 'process raft request' (duration: 21.296263ms)","trace[1875347090] 'compare' (duration: 348.56421ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T00:26:34.943586Z","caller":"traceutil/trace.go:171","msg":"trace[1165062324] linearizableReadLoop","detail":"{readStateIndex:5099; appliedIndex:5097; }","duration":"353.896614ms","start":"2026-07-16T00:26:34.588826Z","end":"2026-07-16T00:26:34.942723Z","steps":["trace[1165062324] 'read index received' (duration: 2.674032ms)","trace[1165062324] 'applied index is now lower than readState.Index' (duration: 351.218392ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T00:26:34.943803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:34.570229Z","time spent":"373.513163ms","remote":"127.0.0.1:54262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":794,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-16T00:26:34.943894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.810159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-16T00:26:34.94395Z","caller":"traceutil/trace.go:171","msg":"trace[718533518] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4919; }","duration":"354.910713ms","start":"2026-07-16T00:26:34.589022Z","end":"2026-07-16T00:26:34.943932Z","steps":["trace[718533518] 'agreement among raft nodes before linearized reading' (duration: 354.700485ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:26:34.944004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:34.588994Z","time spent":"354.999196ms","remote":"127.0.0.1:54458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-16T00:26:34.943169Z","caller":"traceutil/trace.go:171","msg":"trace[1149990393] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4919; }","duration":"354.345061ms","start":"2026-07-16T00:26:34.588811Z","end":"2026-07-16T00:26:34.943156Z","steps":["trace[1149990393] 'agreement among raft nodes before linearized reading' (duration: 354.158864ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T00:26:34.944424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T00:26:34.588805Z","time spent":"355.606929ms","remote":"127.0.0.1:54458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-16T00:27:52.029176Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2875} {"level":"info","ts":"2026-07-16T00:27:52.140503Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2875,"took":"109.721772ms","hash":1078343746,"current-db-size-bytes":54067200,"current-db-size":"54 MB","current-db-size-in-use-bytes":29093888,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-16T00:27:52.140587Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1078343746,"revision":2875,"compact-revision":-1} {"level":"info","ts":"2026-07-16T00:32:52.036283Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5548} {"level":"info","ts":"2026-07-16T00:32:52.111961Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5548,"took":"74.507208ms","hash":4238805092,"current-db-size-bytes":54067200,"current-db-size":"54 MB","current-db-size-in-use-bytes":18305024,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-16T00:32:52.112052Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4238805092,"revision":5548,"compact-revision":2875}