{"level":"warn","ts":"2026-07-30T18:56:34.869346Z","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-30T18:56:34.86948Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.242: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.242:2380","--initial-cluster=instance=https://199.204.45.242:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.242:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.242: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-30T18:56:34.869596Z","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-30T18:56:34.869619Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-07-30T18:56:34.869648Z","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-30T18:56:34.870869Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"]} {"level":"info","ts":"2026-07-30T18:56:34.871008Z","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.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.242: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-30T18:56:34.873731Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.391484ms"} {"level":"info","ts":"2026-07-30T18:56:34.879109Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b844c110b9783e73","cluster-id":"49dc9693ccd466a9"} {"level":"info","ts":"2026-07-30T18:56:34.879192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=()"} {"level":"info","ts":"2026-07-30T18:56:34.879214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 0"} {"level":"info","ts":"2026-07-30T18:56:34.879229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b844c110b9783e73 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-30T18:56:34.879239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 1"} {"level":"info","ts":"2026-07-30T18:56:34.879275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"warn","ts":"2026-07-30T18:56:34.890166Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-30T18:56:34.891532Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-30T18:56:34.893049Z","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-30T18:56:34.895817Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b844c110b9783e73","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-30T18:56:34.896146Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b844c110b9783e73","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-30T18:56:34.896269Z","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-30T18:56:34.896461Z","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-30T18:56:34.896502Z","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-30T18:56:34.898129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"info","ts":"2026-07-30T18:56:34.898392Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","added-peer-id":"b844c110b9783e73","added-peer-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-07-30T18:56:34.901661Z","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-30T18:56:34.901814Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-07-30T18:56:34.901881Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-07-30T18:56:34.901896Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b844c110b9783e73","initial-advertise-peer-urls":["https://199.204.45.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-30T18:56:34.901924Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-30T18:56:35.48003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 is starting a new election at term 1"} {"level":"info","ts":"2026-07-30T18:56:35.480159Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-30T18:56:35.480194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgPreVoteResp from b844c110b9783e73 at term 1"} {"level":"info","ts":"2026-07-30T18:56:35.480219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became candidate at term 2"} {"level":"info","ts":"2026-07-30T18:56:35.480233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgVoteResp from b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-07-30T18:56:35.480254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became leader at term 2"} {"level":"info","ts":"2026-07-30T18:56:35.480277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b844c110b9783e73 elected leader b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-07-30T18:56:35.48156Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T18:56:35.482424Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b844c110b9783e73","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.242:2379]}","request-path":"/0/members/b844c110b9783e73/attributes","cluster-id":"49dc9693ccd466a9","publish-timeout":"7s"} {"level":"info","ts":"2026-07-30T18:56:35.483224Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-30T18:56:35.483296Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T18:56:35.483282Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-30T18:56:35.483425Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T18:56:35.483469Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T18:56:35.483579Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-30T18:56:35.483648Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-30T18:56:35.485303Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.242:2379"} {"level":"info","ts":"2026-07-30T18:56:35.486393Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-30T18:57:18.941622Z","caller":"traceutil/trace.go:171","msg":"trace[1373198738] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"142.361467ms","start":"2026-07-30T18:57:18.799207Z","end":"2026-07-30T18:57:18.941568Z","steps":["trace[1373198738] 'read index received' (duration: 65.356448ms)","trace[1373198738] 'applied index is now lower than readState.Index' (duration: 77.002139ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T18:57:18.941962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.713563ms","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-30T18:57:18.942149Z","caller":"traceutil/trace.go:171","msg":"trace[666734859] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:589; }","duration":"142.976759ms","start":"2026-07-30T18:57:18.799136Z","end":"2026-07-30T18:57:18.942113Z","steps":["trace[666734859] 'agreement among raft nodes before linearized reading' (duration: 142.56134ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:57:18.98789Z","caller":"traceutil/trace.go:171","msg":"trace[1584016860] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"147.441434ms","start":"2026-07-30T18:57:18.8404Z","end":"2026-07-30T18:57:18.987842Z","steps":["trace[1584016860] 'process raft request' (duration: 147.23019ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T18:57:19.176015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.707833ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T18:57:19.176318Z","caller":"traceutil/trace.go:171","msg":"trace[1984021252] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"172.704462ms","start":"2026-07-30T18:57:19.003593Z","end":"2026-07-30T18:57:19.176297Z","steps":["trace[1984021252] 'process raft request' (duration: 172.638591ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:57:19.176476Z","caller":"traceutil/trace.go:171","msg":"trace[920752108] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"229.665211ms","start":"2026-07-30T18:57:18.946771Z","end":"2026-07-30T18:57:19.176436Z","steps":["trace[920752108] 'process raft request' (duration: 229.377996ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:57:19.176617Z","caller":"traceutil/trace.go:171","msg":"trace[1980263632] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:613; }","duration":"186.089135ms","start":"2026-07-30T18:57:18.990321Z","end":"2026-07-30T18:57:19.17641Z","steps":["trace[1980263632] 'read index received' (duration: 51.517835ms)","trace[1980263632] 'applied index is now lower than readState.Index' (duration: 134.56832ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T18:57:19.176859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.534714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T18:57:19.176888Z","caller":"traceutil/trace.go:171","msg":"trace[1690904816] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"233.555774ms","start":"2026-07-30T18:57:18.942721Z","end":"2026-07-30T18:57:19.176277Z","steps":["trace[1690904816] 'process raft request' (duration: 98.894263ms)","trace[1690904816] 'compare' (duration: 133.52384ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T18:57:19.176926Z","caller":"traceutil/trace.go:171","msg":"trace[671118760] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"186.606425ms","start":"2026-07-30T18:57:18.990303Z","end":"2026-07-30T18:57:19.17691Z","steps":["trace[671118760] 'agreement among raft nodes before linearized reading' (duration: 186.499173ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T18:57:19.177067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.319388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T18:57:19.177156Z","caller":"traceutil/trace.go:171","msg":"trace[1519066533] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:593; }","duration":"178.47286ms","start":"2026-07-30T18:57:18.998663Z","end":"2026-07-30T18:57:19.177136Z","steps":["trace[1519066533] 'agreement among raft nodes before linearized reading' (duration: 178.203385ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:58:45.39374Z","caller":"traceutil/trace.go:171","msg":"trace[81626183] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"118.764289ms","start":"2026-07-30T18:58:45.274945Z","end":"2026-07-30T18:58:45.39371Z","steps":["trace[81626183] 'process raft request' (duration: 118.582726ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:58:46.547251Z","caller":"traceutil/trace.go:171","msg":"trace[1088326543] linearizableReadLoop","detail":"{readStateIndex:1399; appliedIndex:1398; }","duration":"110.266217ms","start":"2026-07-30T18:58:46.436948Z","end":"2026-07-30T18:58:46.547214Z","steps":["trace[1088326543] 'read index received' (duration: 110.012222ms)","trace[1088326543] 'applied index is now lower than readState.Index' (duration: 253.115µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T18:58:46.547314Z","caller":"traceutil/trace.go:171","msg":"trace[633698263] transaction","detail":"{read_only:false; response_revision:1355; number_of_response:1; }","duration":"111.565752ms","start":"2026-07-30T18:58:46.435717Z","end":"2026-07-30T18:58:46.547283Z","steps":["trace[633698263] 'process raft request' (duration: 111.315997ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T18:58:46.547435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.45278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-30T18:58:46.547498Z","caller":"traceutil/trace.go:171","msg":"trace[1582611608] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1355; }","duration":"110.561933ms","start":"2026-07-30T18:58:46.43692Z","end":"2026-07-30T18:58:46.547482Z","steps":["trace[1582611608] 'agreement among raft nodes before linearized reading' (duration: 110.43346ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:58:48.510608Z","caller":"traceutil/trace.go:171","msg":"trace[1376464510] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"112.019521ms","start":"2026-07-30T18:58:48.398554Z","end":"2026-07-30T18:58:48.510573Z","steps":["trace[1376464510] 'process raft request' (duration: 111.810667ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T18:58:48.874942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.429068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.242\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-30T18:58:48.875036Z","caller":"traceutil/trace.go:171","msg":"trace[180690339] range","detail":"{range_begin:/registry/masterleases/199.204.45.242; range_end:; response_count:1; response_revision:1364; }","duration":"124.587701ms","start":"2026-07-30T18:58:48.750424Z","end":"2026-07-30T18:58:48.875012Z","steps":["trace[180690339] 'range keys from in-memory index tree' (duration: 124.241334ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:59:38.133637Z","caller":"traceutil/trace.go:171","msg":"trace[262959679] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"101.50161ms","start":"2026-07-30T18:59:38.032095Z","end":"2026-07-30T18:59:38.133596Z","steps":["trace[262959679] 'process raft request' (duration: 101.223475ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:59:38.424248Z","caller":"traceutil/trace.go:171","msg":"trace[137768715] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"202.800975ms","start":"2026-07-30T18:59:38.221392Z","end":"2026-07-30T18:59:38.424193Z","steps":["trace[137768715] 'process raft request' (duration: 196.716328ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:59:50.926113Z","caller":"traceutil/trace.go:171","msg":"trace[363580916] transaction","detail":"{read_only:false; response_revision:2246; number_of_response:1; }","duration":"157.601239ms","start":"2026-07-30T18:59:50.768447Z","end":"2026-07-30T18:59:50.926048Z","steps":["trace[363580916] 'process raft request' (duration: 157.315524ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:59:51.080143Z","caller":"traceutil/trace.go:171","msg":"trace[940062492] transaction","detail":"{read_only:false; response_revision:2247; number_of_response:1; }","duration":"140.432001ms","start":"2026-07-30T18:59:50.93966Z","end":"2026-07-30T18:59:51.080092Z","steps":["trace[940062492] 'process raft request' (duration: 129.591004ms)","trace[940062492] 'compare' (duration: 10.694844ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T18:59:51.149955Z","caller":"traceutil/trace.go:171","msg":"trace[522473688] transaction","detail":"{read_only:false; response_revision:2248; number_of_response:1; }","duration":"208.43043ms","start":"2026-07-30T18:59:50.941489Z","end":"2026-07-30T18:59:51.149919Z","steps":["trace[522473688] 'process raft request' (duration: 208.162655ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:59:51.150348Z","caller":"traceutil/trace.go:171","msg":"trace[338934128] linearizableReadLoop","detail":"{readStateIndex:2336; appliedIndex:2331; }","duration":"182.989203ms","start":"2026-07-30T18:59:50.96734Z","end":"2026-07-30T18:59:51.150329Z","steps":["trace[338934128] 'read index received' (duration: 101.998987ms)","trace[338934128] 'applied index is now lower than readState.Index' (duration: 80.989086ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T18:59:51.150349Z","caller":"traceutil/trace.go:171","msg":"trace[1706474610] transaction","detail":"{read_only:false; response_revision:2249; number_of_response:1; }","duration":"207.712026ms","start":"2026-07-30T18:59:50.942554Z","end":"2026-07-30T18:59:51.150266Z","steps":["trace[1706474610] 'process raft request' (duration: 207.285508ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:59:51.150445Z","caller":"traceutil/trace.go:171","msg":"trace[443636298] transaction","detail":"{read_only:false; response_revision:2250; number_of_response:1; }","duration":"206.901511ms","start":"2026-07-30T18:59:50.943467Z","end":"2026-07-30T18:59:51.150369Z","steps":["trace[443636298] 'process raft request' (duration: 206.631716ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T18:59:51.150626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.277189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-07-30T18:59:51.150683Z","caller":"traceutil/trace.go:171","msg":"trace[382307491] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2251; }","duration":"183.403042ms","start":"2026-07-30T18:59:50.967262Z","end":"2026-07-30T18:59:51.150665Z","steps":["trace[382307491] 'agreement among raft nodes before linearized reading' (duration: 183.193438ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:59:51.151673Z","caller":"traceutil/trace.go:171","msg":"trace[1745205548] transaction","detail":"{read_only:false; response_revision:2251; number_of_response:1; }","duration":"207.36394ms","start":"2026-07-30T18:59:50.94422Z","end":"2026-07-30T18:59:51.151584Z","steps":["trace[1745205548] 'process raft request' (duration: 205.992143ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:59:51.239064Z","caller":"traceutil/trace.go:171","msg":"trace[1742210171] transaction","detail":"{read_only:false; response_revision:2252; number_of_response:1; }","duration":"149.489545ms","start":"2026-07-30T18:59:51.089524Z","end":"2026-07-30T18:59:51.239013Z","steps":["trace[1742210171] 'process raft request' (duration: 91.598809ms)","trace[1742210171] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/replicasets/openstack/rabbitmq-cluster-operator-54f767cff8; req_size:5633; } (duration: 57.61808ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T18:59:51.23943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.768346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-kxvsq\" ","response":"range_response_count:1 size:5638"} {"level":"warn","ts":"2026-07-30T18:59:51.239412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.114766ms","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-30T18:59:51.239511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.570621ms","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-30T18:59:51.239524Z","caller":"traceutil/trace.go:171","msg":"trace[1911346411] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-kxvsq; range_end:; response_count:1; response_revision:2254; }","duration":"153.919829ms","start":"2026-07-30T18:59:51.08558Z","end":"2026-07-30T18:59:51.239499Z","steps":["trace[1911346411] 'agreement among raft nodes before linearized reading' (duration: 153.685285ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:59:51.239574Z","caller":"traceutil/trace.go:171","msg":"trace[1992458882] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2254; }","duration":"232.690064ms","start":"2026-07-30T18:59:51.00687Z","end":"2026-07-30T18:59:51.23956Z","steps":["trace[1992458882] 'agreement among raft nodes before linearized reading' (duration: 232.388228ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:59:51.239622Z","caller":"traceutil/trace.go:171","msg":"trace[1931677853] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2254; }","duration":"239.386371ms","start":"2026-07-30T18:59:51.000141Z","end":"2026-07-30T18:59:51.239528Z","steps":["trace[1931677853] 'agreement among raft nodes before linearized reading' (duration: 238.946403ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T18:59:55.018107Z","caller":"traceutil/trace.go:171","msg":"trace[1104959206] transaction","detail":"{read_only:false; response_revision:2283; number_of_response:1; }","duration":"115.290002ms","start":"2026-07-30T18:59:54.902783Z","end":"2026-07-30T18:59:55.018073Z","steps":["trace[1104959206] 'process raft request' (duration: 115.061427ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:00:18.18411Z","caller":"traceutil/trace.go:171","msg":"trace[1832509903] transaction","detail":"{read_only:false; response_revision:2442; number_of_response:1; }","duration":"118.439442ms","start":"2026-07-30T19:00:18.065625Z","end":"2026-07-30T19:00:18.184064Z","steps":["trace[1832509903] 'process raft request' (duration: 118.152916ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:00:18.632771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.610223ms","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-30T19:00:18.6329Z","caller":"traceutil/trace.go:171","msg":"trace[955308063] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2444; }","duration":"164.828898ms","start":"2026-07-30T19:00:18.468039Z","end":"2026-07-30T19:00:18.632868Z","steps":["trace[955308063] 'range keys from in-memory index tree' (duration: 164.368318ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:00:18.902736Z","caller":"traceutil/trace.go:171","msg":"trace[1438258969] linearizableReadLoop","detail":"{readStateIndex:2535; appliedIndex:2534; }","duration":"174.621704ms","start":"2026-07-30T19:00:18.728083Z","end":"2026-07-30T19:00:18.902705Z","steps":["trace[1438258969] 'read index received' (duration: 174.466981ms)","trace[1438258969] 'applied index is now lower than readState.Index' (duration: 153.453µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:00:18.90284Z","caller":"traceutil/trace.go:171","msg":"trace[1265619894] transaction","detail":"{read_only:false; response_revision:2445; number_of_response:1; }","duration":"314.851392ms","start":"2026-07-30T19:00:18.587955Z","end":"2026-07-30T19:00:18.902807Z","steps":["trace[1265619894] 'process raft request' (duration: 314.593487ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:00:18.902941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.841568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:00:18.90298Z","caller":"traceutil/trace.go:171","msg":"trace[231834176] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:2445; }","duration":"174.957431ms","start":"2026-07-30T19:00:18.728012Z","end":"2026-07-30T19:00:18.902969Z","steps":["trace[231834176] 'agreement among raft nodes before linearized reading' (duration: 174.864179ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:00:18.903021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:00:18.587917Z","time spent":"314.997884ms","remote":"127.0.0.1:57298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T19:00:18.903195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.68321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.242\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-30T19:00:18.903301Z","caller":"traceutil/trace.go:171","msg":"trace[618078510] range","detail":"{range_begin:/registry/masterleases/199.204.45.242; range_end:; response_count:1; response_revision:2445; }","duration":"147.859113ms","start":"2026-07-30T19:00:18.755414Z","end":"2026-07-30T19:00:18.903273Z","steps":["trace[618078510] 'agreement among raft nodes before linearized reading' (duration: 147.565388ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:00:18.903497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.112171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-30T19:00:18.903598Z","caller":"traceutil/trace.go:171","msg":"trace[908926584] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2445; }","duration":"122.281694ms","start":"2026-07-30T19:00:18.781295Z","end":"2026-07-30T19:00:18.903576Z","steps":["trace[908926584] 'agreement among raft nodes before linearized reading' (duration: 121.872876ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:00:18.903948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.123401ms","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-30T19:00:18.90402Z","caller":"traceutil/trace.go:171","msg":"trace[726424309] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2445; }","duration":"122.788754ms","start":"2026-07-30T19:00:18.781223Z","end":"2026-07-30T19:00:18.904012Z","steps":["trace[726424309] 'agreement among raft nodes before linearized reading' (duration: 121.954198ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:00:19.009515Z","caller":"traceutil/trace.go:171","msg":"trace[1944334968] transaction","detail":"{read_only:false; response_revision:2446; number_of_response:1; }","duration":"100.56162ms","start":"2026-07-30T19:00:18.908911Z","end":"2026-07-30T19:00:19.009473Z","steps":["trace[1944334968] 'process raft request' (duration: 100.289335ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:00:19.010541Z","caller":"traceutil/trace.go:171","msg":"trace[1989400280] transaction","detail":"{read_only:false; response_revision:2447; number_of_response:1; }","duration":"101.464607ms","start":"2026-07-30T19:00:18.909043Z","end":"2026-07-30T19:00:19.010507Z","steps":["trace[1989400280] 'process raft request' (duration: 100.372837ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:02:12.204726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.00431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18c72680d332e571\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-07-30T19:02:12.204856Z","caller":"traceutil/trace.go:171","msg":"trace[373145582] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18c72680d332e571; range_end:; response_count:1; response_revision:3250; }","duration":"184.176663ms","start":"2026-07-30T19:02:12.020652Z","end":"2026-07-30T19:02:12.204828Z","steps":["trace[373145582] 'range keys from in-memory index tree' (duration: 183.739635ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:02:12.205065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.383653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-30T19:02:12.20518Z","caller":"traceutil/trace.go:171","msg":"trace[1232993669] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:3250; }","duration":"177.592897ms","start":"2026-07-30T19:02:12.02756Z","end":"2026-07-30T19:02:12.205153Z","steps":["trace[1232993669] 'range keys from in-memory index tree' (duration: 177.22287ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:02:12.540567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.311663ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T19:02:12.540727Z","caller":"traceutil/trace.go:171","msg":"trace[209208065] linearizableReadLoop","detail":"{readStateIndex:3369; appliedIndex:3368; }","duration":"146.081088ms","start":"2026-07-30T19:02:12.394622Z","end":"2026-07-30T19:02:12.540703Z","steps":["trace[209208065] 'read index received' (duration: 13.505131ms)","trace[209208065] 'applied index is now lower than readState.Index' (duration: 132.557027ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:02:12.540821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.202381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:02:12.540754Z","caller":"traceutil/trace.go:171","msg":"trace[1631517881] transaction","detail":"{read_only:false; response_revision:3255; number_of_response:1; }","duration":"249.83462ms","start":"2026-07-30T19:02:12.290873Z","end":"2026-07-30T19:02:12.540708Z","steps":["trace[1631517881] 'process raft request' (duration: 117.270073ms)","trace[1631517881] 'compare' (duration: 131.960966ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:02:12.540865Z","caller":"traceutil/trace.go:171","msg":"trace[237473169] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:3255; }","duration":"146.295623ms","start":"2026-07-30T19:02:12.394557Z","end":"2026-07-30T19:02:12.540853Z","steps":["trace[237473169] 'agreement among raft nodes before linearized reading' (duration: 146.205211ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:06:35.617576Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2969} {"level":"info","ts":"2026-07-30T19:06:35.696496Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2969,"took":"77.648847ms","hash":999019560,"current-db-size-bytes":35180544,"current-db-size":"35 MB","current-db-size-in-use-bytes":10514432,"current-db-size-in-use":"10 MB"} {"level":"info","ts":"2026-07-30T19:06:35.696595Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":999019560,"revision":2969,"compact-revision":-1} {"level":"info","ts":"2026-07-30T19:10:24.782548Z","caller":"traceutil/trace.go:171","msg":"trace[14289959] transaction","detail":"{read_only:false; response_revision:6559; number_of_response:1; }","duration":"178.516972ms","start":"2026-07-30T19:10:24.603996Z","end":"2026-07-30T19:10:24.782513Z","steps":["trace[14289959] 'process raft request' (duration: 178.269778ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:11:35.624794Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4939} {"level":"info","ts":"2026-07-30T19:11:35.665477Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4939,"took":"39.336393ms","hash":1772854840,"current-db-size-bytes":35180544,"current-db-size":"35 MB","current-db-size-in-use-bytes":11472896,"current-db-size-in-use":"12 MB"} {"level":"info","ts":"2026-07-30T19:11:35.665553Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1772854840,"revision":4939,"compact-revision":2969} {"level":"warn","ts":"2026-07-30T19:15:29.012481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.484565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:15:29.012595Z","caller":"traceutil/trace.go:171","msg":"trace[1168476336] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9053; }","duration":"113.655179ms","start":"2026-07-30T19:15:28.898915Z","end":"2026-07-30T19:15:29.012571Z","steps":["trace[1168476336] 'range keys from in-memory index tree' (duration: 113.400444ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:15:29.012671Z","caller":"traceutil/trace.go:171","msg":"trace[32775127] transaction","detail":"{read_only:false; response_revision:9054; number_of_response:1; }","duration":"111.604889ms","start":"2026-07-30T19:15:28.901025Z","end":"2026-07-30T19:15:29.01263Z","steps":["trace[32775127] 'process raft request' (duration: 65.169153ms)","trace[32775127] 'compare' (duration: 46.192401ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:15:29.175324Z","caller":"traceutil/trace.go:171","msg":"trace[1797464264] transaction","detail":"{read_only:false; response_revision:9056; number_of_response:1; }","duration":"158.518472ms","start":"2026-07-30T19:15:29.016774Z","end":"2026-07-30T19:15:29.175293Z","steps":["trace[1797464264] 'process raft request' (duration: 158.219197ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:15:29.175519Z","caller":"traceutil/trace.go:171","msg":"trace[868226353] transaction","detail":"{read_only:false; response_revision:9057; number_of_response:1; }","duration":"158.007313ms","start":"2026-07-30T19:15:29.017476Z","end":"2026-07-30T19:15:29.175483Z","steps":["trace[868226353] 'process raft request' (duration: 157.766919ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:16:35.632858Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7194} {"level":"info","ts":"2026-07-30T19:16:35.689154Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7194,"took":"54.93ms","hash":2608009503,"current-db-size-bytes":35180544,"current-db-size":"35 MB","current-db-size-in-use-bytes":12767232,"current-db-size-in-use":"13 MB"} {"level":"info","ts":"2026-07-30T19:16:35.689243Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2608009503,"revision":7194,"compact-revision":4939} {"level":"info","ts":"2026-07-30T19:16:49.454402Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b844c110b9783e73","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-30T19:16:49.461434Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-30T19:16:49.461553Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-30T19:21:23.061204Z","caller":"traceutil/trace.go:171","msg":"trace[637106453] linearizableReadLoop","detail":"{readStateIndex:12194; appliedIndex:12193; }","duration":"162.189972ms","start":"2026-07-30T19:21:22.898994Z","end":"2026-07-30T19:21:23.061184Z","steps":["trace[637106453] 'read index received' (duration: 121.28428ms)","trace[637106453] 'applied index is now lower than readState.Index' (duration: 40.904992ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:21:23.061254Z","caller":"traceutil/trace.go:171","msg":"trace[914762593] transaction","detail":"{read_only:false; response_revision:11815; number_of_response:1; }","duration":"262.857199ms","start":"2026-07-30T19:21:22.798362Z","end":"2026-07-30T19:21:23.061219Z","steps":["trace[914762593] 'process raft request' (duration: 221.928546ms)","trace[914762593] 'compare' (duration: 40.626827ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:21:23.061347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.339186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:21:23.061379Z","caller":"traceutil/trace.go:171","msg":"trace[879247263] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11815; }","duration":"162.419458ms","start":"2026-07-30T19:21:22.898951Z","end":"2026-07-30T19:21:23.061371Z","steps":["trace[879247263] 'agreement among raft nodes before linearized reading' (duration: 162.352285ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:21:23.061525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.55856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-30T19:21:23.06161Z","caller":"traceutil/trace.go:171","msg":"trace[967883641] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11815; }","duration":"140.684003ms","start":"2026-07-30T19:21:22.920906Z","end":"2026-07-30T19:21:23.06159Z","steps":["trace[967883641] 'agreement among raft nodes before linearized reading' (duration: 140.470609ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:21:35.639548Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9571} {"level":"info","ts":"2026-07-30T19:21:35.699728Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9571,"took":"58.51634ms","hash":4262656704,"current-db-size-bytes":35180544,"current-db-size":"35 MB","current-db-size-in-use-bytes":14811136,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-07-30T19:21:35.699795Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4262656704,"revision":9571,"compact-revision":7194} {"level":"info","ts":"2026-07-30T19:22:57.972244Z","caller":"traceutil/trace.go:171","msg":"trace[2005355609] transaction","detail":"{read_only:false; response_revision:12969; number_of_response:1; }","duration":"110.804861ms","start":"2026-07-30T19:22:57.861414Z","end":"2026-07-30T19:22:57.972219Z","steps":["trace[2005355609] 'process raft request' (duration: 110.623537ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:22:58.230078Z","caller":"traceutil/trace.go:171","msg":"trace[326265450] transaction","detail":"{read_only:false; response_revision:12970; number_of_response:1; }","duration":"252.502131ms","start":"2026-07-30T19:22:57.977544Z","end":"2026-07-30T19:22:58.230046Z","steps":["trace[326265450] 'process raft request' (duration: 220.541799ms)","trace[326265450] 'compare' (duration: 31.792839ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:22:58.251835Z","caller":"traceutil/trace.go:171","msg":"trace[1093864705] linearizableReadLoop","detail":"{readStateIndex:13382; appliedIndex:13380; }","duration":"262.31598ms","start":"2026-07-30T19:22:57.989501Z","end":"2026-07-30T19:22:58.251817Z","steps":["trace[1093864705] 'read index received' (duration: 208.419278ms)","trace[1093864705] 'applied index is now lower than readState.Index' (duration: 53.896042ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:22:58.252021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.340371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:22:58.252062Z","caller":"traceutil/trace.go:171","msg":"trace[114389833] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:12971; }","duration":"262.425292ms","start":"2026-07-30T19:22:57.989627Z","end":"2026-07-30T19:22:58.252052Z","steps":["trace[114389833] 'agreement among raft nodes before linearized reading' (duration: 262.34112ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:22:58.252036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.505294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:22:58.252123Z","caller":"traceutil/trace.go:171","msg":"trace[20401773] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:12971; }","duration":"262.630346ms","start":"2026-07-30T19:22:57.989472Z","end":"2026-07-30T19:22:58.252103Z","steps":["trace[20401773] 'agreement among raft nodes before linearized reading' (duration: 262.479653ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:22:58.25219Z","caller":"traceutil/trace.go:171","msg":"trace[1898737568] transaction","detail":"{read_only:false; response_revision:12971; number_of_response:1; }","duration":"274.083885ms","start":"2026-07-30T19:22:57.97794Z","end":"2026-07-30T19:22:58.252024Z","steps":["trace[1898737568] 'process raft request' (duration: 273.79625ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:22:58.252777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.235683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"info","ts":"2026-07-30T19:22:58.252862Z","caller":"traceutil/trace.go:171","msg":"trace[83416455] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:12971; }","duration":"257.337234ms","start":"2026-07-30T19:22:57.995506Z","end":"2026-07-30T19:22:58.252843Z","steps":["trace[83416455] 'agreement among raft nodes before linearized reading' (duration: 256.643361ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:22:58.252275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.7976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-2vmlz\" ","response":"range_response_count:1 size:20565"} {"level":"warn","ts":"2026-07-30T19:22:58.252291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.593115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-30T19:22:58.252336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.891157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T19:22:58.253073Z","caller":"traceutil/trace.go:171","msg":"trace[551025937] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:12971; }","duration":"263.37847ms","start":"2026-07-30T19:22:57.989658Z","end":"2026-07-30T19:22:58.253037Z","steps":["trace[551025937] 'agreement among raft nodes before linearized reading' (duration: 262.576485ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:22:58.253134Z","caller":"traceutil/trace.go:171","msg":"trace[964896565] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:12971; }","duration":"129.701971ms","start":"2026-07-30T19:22:58.123408Z","end":"2026-07-30T19:22:58.25311Z","steps":["trace[964896565] 'agreement among raft nodes before linearized reading' (duration: 128.905337ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:22:58.252641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.898208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"} {"level":"info","ts":"2026-07-30T19:22:58.253384Z","caller":"traceutil/trace.go:171","msg":"trace[1371368513] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:12971; }","duration":"128.697593ms","start":"2026-07-30T19:22:58.124658Z","end":"2026-07-30T19:22:58.253355Z","steps":["trace[1371368513] 'agreement among raft nodes before linearized reading' (duration: 127.633133ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:22:58.252978Z","caller":"traceutil/trace.go:171","msg":"trace[1908317828] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-2vmlz; range_end:; response_count:1; response_revision:12971; }","duration":"215.514974ms","start":"2026-07-30T19:22:58.037425Z","end":"2026-07-30T19:22:58.25294Z","steps":["trace[1908317828] 'agreement among raft nodes before linearized reading' (duration: 214.650568ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:22:59.243534Z","caller":"traceutil/trace.go:171","msg":"trace[710249442] transaction","detail":"{read_only:false; response_revision:12977; number_of_response:1; }","duration":"109.301111ms","start":"2026-07-30T19:22:59.134203Z","end":"2026-07-30T19:22:59.243504Z","steps":["trace[710249442] 'process raft request' (duration: 109.054385ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:26:35.648072Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12084} {"level":"info","ts":"2026-07-30T19:26:35.71646Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12084,"took":"67.094263ms","hash":3585309556,"current-db-size-bytes":35180544,"current-db-size":"35 MB","current-db-size-in-use-bytes":15859712,"current-db-size-in-use":"16 MB"} {"level":"info","ts":"2026-07-30T19:26:35.716519Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3585309556,"revision":12084,"compact-revision":9571} {"level":"info","ts":"2026-07-30T19:27:13.917667Z","caller":"traceutil/trace.go:171","msg":"trace[77613763] transaction","detail":"{read_only:false; response_revision:14695; number_of_response:1; }","duration":"112.289388ms","start":"2026-07-30T19:27:13.805351Z","end":"2026-07-30T19:27:13.91764Z","steps":["trace[77613763] 'process raft request' (duration: 107.107419ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:31:35.654841Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14392} {"level":"info","ts":"2026-07-30T19:31:35.730749Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14392,"took":"73.740501ms","hash":3681457559,"current-db-size-bytes":35180544,"current-db-size":"35 MB","current-db-size-in-use-bytes":16236544,"current-db-size-in-use":"16 MB"} {"level":"info","ts":"2026-07-30T19:31:35.730842Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3681457559,"revision":14392,"compact-revision":12084} {"level":"info","ts":"2026-07-30T19:35:43.692355Z","caller":"traceutil/trace.go:171","msg":"trace[747568072] linearizableReadLoop","detail":"{readStateIndex:19199; appliedIndex:19198; }","duration":"161.605877ms","start":"2026-07-30T19:35:43.530726Z","end":"2026-07-30T19:35:43.692332Z","steps":["trace[747568072] 'read index received' (duration: 145.506739ms)","trace[747568072] 'applied index is now lower than readState.Index' (duration: 16.098238ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:35:43.692438Z","caller":"traceutil/trace.go:171","msg":"trace[2121706094] transaction","detail":"{read_only:false; response_revision:18617; number_of_response:1; }","duration":"215.025647ms","start":"2026-07-30T19:35:43.477373Z","end":"2026-07-30T19:35:43.692399Z","steps":["trace[2121706094] 'process raft request' (duration: 198.839798ms)","trace[2121706094] 'compare' (duration: 16.009866ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:35:43.6926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.860201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-metadata-agent-default-spznb\" ","response":"range_response_count:1 size:14297"} {"level":"info","ts":"2026-07-30T19:35:43.692636Z","caller":"traceutil/trace.go:171","msg":"trace[1000316606] range","detail":"{range_begin:/registry/pods/openstack/neutron-metadata-agent-default-spznb; range_end:; response_count:1; response_revision:18617; }","duration":"161.940983ms","start":"2026-07-30T19:35:43.530685Z","end":"2026-07-30T19:35:43.692626Z","steps":["trace[1000316606] 'agreement among raft nodes before linearized reading' (duration: 161.77034ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:35:43.692649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.918424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-07-30T19:35:43.692718Z","caller":"traceutil/trace.go:171","msg":"trace[2074042170] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:18617; }","duration":"115.021257ms","start":"2026-07-30T19:35:43.577674Z","end":"2026-07-30T19:35:43.692696Z","steps":["trace[2074042170] 'agreement among raft nodes before linearized reading' (duration: 114.857334ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:35:50.166524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.851702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:476"} {"level":"info","ts":"2026-07-30T19:35:50.166603Z","caller":"traceutil/trace.go:171","msg":"trace[1872403] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:18674; }","duration":"226.971045ms","start":"2026-07-30T19:35:49.939614Z","end":"2026-07-30T19:35:50.166586Z","steps":["trace[1872403] 'range keys from in-memory index tree' (duration: 226.68948ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:35:50.166929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.112543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-30T19:35:50.167034Z","caller":"traceutil/trace.go:171","msg":"trace[80593157] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18674; }","duration":"143.290296ms","start":"2026-07-30T19:35:50.023722Z","end":"2026-07-30T19:35:50.167012Z","steps":["trace[80593157] 'range keys from in-memory index tree' (duration: 142.899339ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:35:50.167274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.341438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-30T19:35:50.167321Z","caller":"traceutil/trace.go:171","msg":"trace[1433087061] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:18674; }","duration":"221.416859ms","start":"2026-07-30T19:35:49.945892Z","end":"2026-07-30T19:35:50.167309Z","steps":["trace[1433087061] 'count revisions from in-memory index tree' (duration: 221.276876ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:35:50.167304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.555772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-30T19:35:50.167373Z","caller":"traceutil/trace.go:171","msg":"trace[298817032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18674; }","duration":"143.671374ms","start":"2026-07-30T19:35:50.023685Z","end":"2026-07-30T19:35:50.167356Z","steps":["trace[298817032] 'range keys from in-memory index tree' (duration: 143.322788ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:35:50.59545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.908731ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-30T19:35:50.595547Z","caller":"traceutil/trace.go:171","msg":"trace[1217379041] linearizableReadLoop","detail":"{readStateIndex:19262; appliedIndex:19261; }","duration":"329.363579ms","start":"2026-07-30T19:35:50.266167Z","end":"2026-07-30T19:35:50.59553Z","steps":["trace[1217379041] 'read index received' (duration: 156.299575ms)","trace[1217379041] 'applied index is now lower than readState.Index' (duration: 173.062864ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T19:35:50.59563Z","caller":"traceutil/trace.go:171","msg":"trace[1627732826] transaction","detail":"{read_only:false; response_revision:18678; number_of_response:1; }","duration":"423.152411ms","start":"2026-07-30T19:35:50.172416Z","end":"2026-07-30T19:35:50.595569Z","steps":["trace[1627732826] 'process raft request' (duration: 250.040336ms)","trace[1627732826] 'compare' (duration: 172.758639ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:35:50.595765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.580923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-07-30T19:35:50.595805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:35:50.172397Z","time spent":"423.317744ms","remote":"127.0.0.1:57298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T19:35:50.59584Z","caller":"traceutil/trace.go:171","msg":"trace[410012540] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18678; }","duration":"329.704777ms","start":"2026-07-30T19:35:50.266116Z","end":"2026-07-30T19:35:50.595821Z","steps":["trace[410012540] 'agreement among raft nodes before linearized reading' (duration: 329.477482ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:35:50.59594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:35:50.266091Z","time spent":"329.835159ms","remote":"127.0.0.1:57298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-30T19:35:50.707998Z","caller":"traceutil/trace.go:171","msg":"trace[1728588488] transaction","detail":"{read_only:false; response_revision:18680; number_of_response:1; }","duration":"108.058904ms","start":"2026-07-30T19:35:50.599913Z","end":"2026-07-30T19:35:50.707971Z","steps":["trace[1728588488] 'process raft request' (duration: 108.009333ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:35:50.708398Z","caller":"traceutil/trace.go:171","msg":"trace[1913500583] transaction","detail":"{read_only:false; response_revision:18679; number_of_response:1; }","duration":"182.911284ms","start":"2026-07-30T19:35:50.525474Z","end":"2026-07-30T19:35:50.708385Z","steps":["trace[1913500583] 'process raft request' (duration: 181.913395ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:35:50.708551Z","caller":"traceutil/trace.go:171","msg":"trace[254184328] linearizableReadLoop","detail":"{readStateIndex:19263; appliedIndex:19262; }","duration":"112.957848ms","start":"2026-07-30T19:35:50.595571Z","end":"2026-07-30T19:35:50.708529Z","steps":["trace[254184328] 'read index received' (duration: 111.758555ms)","trace[254184328] 'applied index is now lower than readState.Index' (duration: 1.198153ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T19:35:50.708678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.977825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-30T19:35:50.708723Z","caller":"traceutil/trace.go:171","msg":"trace[2027631363] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:18680; }","duration":"426.063977ms","start":"2026-07-30T19:35:50.282645Z","end":"2026-07-30T19:35:50.708709Z","steps":["trace[2027631363] 'agreement among raft nodes before linearized reading' (duration: 425.971535ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T19:35:50.708769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T19:35:50.282611Z","time spent":"426.144028ms","remote":"127.0.0.1:54180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-07-30T19:35:50.708841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.31972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-07-30T19:35:50.708935Z","caller":"traceutil/trace.go:171","msg":"trace[1365812927] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:18680; }","duration":"262.446262ms","start":"2026-07-30T19:35:50.446464Z","end":"2026-07-30T19:35:50.70891Z","steps":["trace[1365812927] 'agreement among raft nodes before linearized reading' (duration: 262.182207ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:35:57.64028Z","caller":"traceutil/trace.go:171","msg":"trace[1276610011] transaction","detail":"{read_only:false; response_revision:18785; number_of_response:1; }","duration":"133.659373ms","start":"2026-07-30T19:35:57.506595Z","end":"2026-07-30T19:35:57.640254Z","steps":["trace[1276610011] 'process raft request' (duration: 133.514681ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T19:36:35.662315Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16829} {"level":"info","ts":"2026-07-30T19:36:35.739062Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16829,"took":"74.856939ms","hash":2695350209,"current-db-size-bytes":35180544,"current-db-size":"35 MB","current-db-size-in-use-bytes":17059840,"current-db-size-in-use":"17 MB"} {"level":"info","ts":"2026-07-30T19:36:35.739136Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2695350209,"revision":16829,"compact-revision":14392} {"level":"info","ts":"2026-07-30T19:37:16.765729Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b844c110b9783e73","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-30T19:37:16.771675Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-30T19:37:16.771773Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-07-30T19:41:35.669612Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19120} {"level":"info","ts":"2026-07-30T19:41:35.748279Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19120,"took":"75.40114ms","hash":1112514,"current-db-size-bytes":35180544,"current-db-size":"35 MB","current-db-size-in-use-bytes":15220736,"current-db-size-in-use":"15 MB"} {"level":"info","ts":"2026-07-30T19:41:35.748339Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1112514,"revision":19120,"compact-revision":16829} {"level":"info","ts":"2026-07-30T19:46:35.675787Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21053} {"level":"info","ts":"2026-07-30T19:46:35.741327Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21053,"took":"63.520255ms","hash":1991549041,"current-db-size-bytes":35180544,"current-db-size":"35 MB","current-db-size-in-use-bytes":14446592,"current-db-size-in-use":"14 MB"} {"level":"info","ts":"2026-07-30T19:46:35.741403Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1991549041,"revision":21053,"compact-revision":19120}