{"level":"warn","ts":"2026-05-25T17:53:11.778943Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-25T17:53:11.779039Z","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-05-25T17:53:11.779107Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-25T17:53:11.779124Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-05-25T17:53:11.779153Z","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-05-25T17:53:11.780018Z","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-05-25T17:53:11.780093Z","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-05-25T17:53:11.783422Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.112808ms"} {"level":"info","ts":"2026-05-25T17:53:11.789447Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b844c110b9783e73","cluster-id":"49dc9693ccd466a9"} {"level":"info","ts":"2026-05-25T17:53:11.789575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=()"} {"level":"info","ts":"2026-05-25T17:53:11.789624Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 0"} {"level":"info","ts":"2026-05-25T17:53:11.789662Z","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-05-25T17:53:11.789696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 1"} {"level":"info","ts":"2026-05-25T17:53:11.789772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"warn","ts":"2026-05-25T17:53:11.800357Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-25T17:53:11.801807Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-25T17:53:11.802953Z","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-05-25T17:53:11.805279Z","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-05-25T17:53:11.805526Z","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-05-25T17:53:11.805579Z","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-05-25T17:53:11.805693Z","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-05-25T17:53:11.805719Z","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-05-25T17:53:11.807763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"info","ts":"2026-05-25T17:53:11.80817Z","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-05-25T17:53:11.811124Z","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-05-25T17:53:11.811253Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-05-25T17:53:11.811292Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-05-25T17:53:11.811506Z","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-05-25T17:53:11.811557Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-25T17:53:12.090257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 is starting a new election at term 1"} {"level":"info","ts":"2026-05-25T17:53:12.090327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-25T17:53:12.090374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgPreVoteResp from b844c110b9783e73 at term 1"} {"level":"info","ts":"2026-05-25T17:53:12.0904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became candidate at term 2"} {"level":"info","ts":"2026-05-25T17:53:12.090411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgVoteResp from b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-05-25T17:53:12.090427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became leader at term 2"} {"level":"info","ts":"2026-05-25T17:53:12.090444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b844c110b9783e73 elected leader b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-05-25T17:53:12.09149Z","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-05-25T17:53:12.091522Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T17:53:12.09243Z","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-05-25T17:53:12.092519Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-25T17:53:12.092606Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T17:53:12.092582Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-25T17:53:12.092665Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T17:53:12.094368Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-25T17:53:12.094426Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-25T17:53:12.096085Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-25T17:53:12.096103Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.242:2379"} {"level":"info","ts":"2026-05-25T17:53:48.586805Z","caller":"traceutil/trace.go:171","msg":"trace[1966799036] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"101.148811ms","start":"2026-05-25T17:53:48.485631Z","end":"2026-05-25T17:53:48.58678Z","steps":["trace[1966799036] 'process raft request' (duration: 97.524802ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T17:53:54.755457Z","caller":"traceutil/trace.go:171","msg":"trace[50979502] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:615; }","duration":"141.483488ms","start":"2026-05-25T17:53:54.613946Z","end":"2026-05-25T17:53:54.755429Z","steps":["trace[50979502] 'read index received' (duration: 140.678073ms)","trace[50979502] 'applied index is now lower than readState.Index' (duration: 804.395µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T17:53:54.755524Z","caller":"traceutil/trace.go:171","msg":"trace[2013959231] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"212.727775ms","start":"2026-05-25T17:53:54.54276Z","end":"2026-05-25T17:53:54.755488Z","steps":["trace[2013959231] 'process raft request' (duration: 212.170604ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T17:53:54.755634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.633211ms","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-05-25T17:53:54.755701Z","caller":"traceutil/trace.go:171","msg":"trace[1894366770] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:592; }","duration":"141.795804ms","start":"2026-05-25T17:53:54.613894Z","end":"2026-05-25T17:53:54.75569Z","steps":["trace[1894366770] 'agreement among raft nodes before linearized reading' (duration: 141.638841ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T17:53:55.184993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.510259ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-25T17:53:55.185122Z","caller":"traceutil/trace.go:171","msg":"trace[1284356445] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"425.012353ms","start":"2026-05-25T17:53:54.76009Z","end":"2026-05-25T17:53:55.185103Z","steps":["trace[1284356445] 'process raft request' (duration: 258.810201ms)","trace[1284356445] 'compare' (duration: 165.404077ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T17:53:55.185292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T17:53:54.76007Z","time spent":"425.155276ms","remote":"127.0.0.1:41398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T17:53:55.199894Z","caller":"traceutil/trace.go:171","msg":"trace[560082749] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:616; }","duration":"364.828703ms","start":"2026-05-25T17:53:54.835024Z","end":"2026-05-25T17:53:55.199853Z","steps":["trace[560082749] 'read index received' (duration: 183.885355ms)","trace[560082749] 'applied index is now lower than readState.Index' (duration: 180.941738ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T17:53:55.200076Z","caller":"traceutil/trace.go:171","msg":"trace[22581571] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"392.148007ms","start":"2026-05-25T17:53:54.807831Z","end":"2026-05-25T17:53:55.199979Z","steps":["trace[22581571] 'process raft request' (duration: 391.77897ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T17:53:55.200273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.126523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-crbgd\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-05-25T17:53:55.200291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.251021ms","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-05-25T17:53:55.200421Z","caller":"traceutil/trace.go:171","msg":"trace[575096717] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:594; }","duration":"365.400324ms","start":"2026-05-25T17:53:54.834992Z","end":"2026-05-25T17:53:55.200392Z","steps":["trace[575096717] 'agreement among raft nodes before linearized reading' (duration: 365.029598ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T17:53:55.200337Z","caller":"traceutil/trace.go:171","msg":"trace[1756844605] range","detail":"{range_begin:/registry/pods/kube-system/cilium-crbgd; range_end:; response_count:1; response_revision:594; }","duration":"287.235255ms","start":"2026-05-25T17:53:54.913085Z","end":"2026-05-25T17:53:55.200321Z","steps":["trace[1756844605] 'agreement among raft nodes before linearized reading' (duration: 286.95713ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T17:53:55.200441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T17:53:54.8078Z","time spent":"392.463072ms","remote":"127.0.0.1:41384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-25T17:53:55.200483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T17:53:54.834978Z","time spent":"365.491406ms","remote":"127.0.0.1:41398","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-05-25T17:54:41.288481Z","caller":"traceutil/trace.go:171","msg":"trace[1557099010] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"153.975349ms","start":"2026-05-25T17:54:41.134482Z","end":"2026-05-25T17:54:41.288457Z","steps":["trace[1557099010] 'process raft request' (duration: 153.844807ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T17:55:26.499285Z","caller":"traceutil/trace.go:171","msg":"trace[1559588120] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"125.870938ms","start":"2026-05-25T17:55:26.373379Z","end":"2026-05-25T17:55:26.49925Z","steps":["trace[1559588120] 'process raft request' (duration: 125.658203ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T17:55:38.78583Z","caller":"traceutil/trace.go:171","msg":"trace[632626670] transaction","detail":"{read_only:false; response_revision:1938; number_of_response:1; }","duration":"113.676057ms","start":"2026-05-25T17:55:38.672126Z","end":"2026-05-25T17:55:38.785803Z","steps":["trace[632626670] 'process raft request' (duration: 113.442703ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T17:55:41.670465Z","caller":"traceutil/trace.go:171","msg":"trace[292489585] transaction","detail":"{read_only:false; response_revision:1956; number_of_response:1; }","duration":"139.422602ms","start":"2026-05-25T17:55:41.531011Z","end":"2026-05-25T17:55:41.670433Z","steps":["trace[292489585] 'process raft request' (duration: 138.146758ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T17:56:15.165002Z","caller":"traceutil/trace.go:171","msg":"trace[1502412384] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"122.40219ms","start":"2026-05-25T17:56:15.042567Z","end":"2026-05-25T17:56:15.164969Z","steps":["trace[1502412384] 'process raft request' (duration: 78.320689ms)","trace[1502412384] 'compare' (duration: 43.928379ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T17:56:15.165052Z","caller":"traceutil/trace.go:171","msg":"trace[1524676412] linearizableReadLoop","detail":"{readStateIndex:2231; appliedIndex:2230; }","duration":"118.989647ms","start":"2026-05-25T17:56:15.046029Z","end":"2026-05-25T17:56:15.165019Z","steps":["trace[1524676412] 'read index received' (duration: 74.870114ms)","trace[1524676412] 'applied index is now lower than readState.Index' (duration: 44.115093ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T17:56:15.16531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.234712ms","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-05-25T17:56:15.165355Z","caller":"traceutil/trace.go:171","msg":"trace[1354635261] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2150; }","duration":"119.350033ms","start":"2026-05-25T17:56:15.045993Z","end":"2026-05-25T17:56:15.165343Z","steps":["trace[1354635261] 'agreement among raft nodes before linearized reading' (duration: 119.137789ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T17:56:21.307644Z","caller":"traceutil/trace.go:171","msg":"trace[1901056334] linearizableReadLoop","detail":"{readStateIndex:2267; appliedIndex:2266; }","duration":"118.875125ms","start":"2026-05-25T17:56:21.188733Z","end":"2026-05-25T17:56:21.307608Z","steps":["trace[1901056334] 'read index received' (duration: 96.442511ms)","trace[1901056334] 'applied index is now lower than readState.Index' (duration: 22.430934ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T17:56:21.307897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.15344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-25T17:56:21.307942Z","caller":"traceutil/trace.go:171","msg":"trace[1435492375] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2182; }","duration":"119.252631ms","start":"2026-05-25T17:56:21.188676Z","end":"2026-05-25T17:56:21.307929Z","steps":["trace[1435492375] 'agreement among raft nodes before linearized reading' (duration: 119.054478ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T17:56:21.30815Z","caller":"traceutil/trace.go:171","msg":"trace[1642573381] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"123.112955ms","start":"2026-05-25T17:56:21.185023Z","end":"2026-05-25T17:56:21.308136Z","steps":["trace[1642573381] 'process raft request' (duration: 100.132632ms)","trace[1642573381] 'compare' (duration: 22.164097ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T17:56:21.650266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.243783ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-25T17:56:21.650717Z","caller":"traceutil/trace.go:171","msg":"trace[1537606264] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"338.098704ms","start":"2026-05-25T17:56:21.312591Z","end":"2026-05-25T17:56:21.65069Z","steps":["trace[1537606264] 'process raft request' (duration: 104.245209ms)","trace[1537606264] 'compare' (duration: 233.05485ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T17:56:21.650794Z","caller":"traceutil/trace.go:171","msg":"trace[1678301225] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"220.607776ms","start":"2026-05-25T17:56:21.430165Z","end":"2026-05-25T17:56:21.650773Z","steps":["trace[1678301225] 'process raft request' (duration: 220.435632ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T17:56:21.650872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T17:56:21.312564Z","time spent":"338.228337ms","remote":"127.0.0.1:41398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T17:56:21.6545Z","caller":"traceutil/trace.go:171","msg":"trace[1774986678] linearizableReadLoop","detail":"{readStateIndex:2270; appliedIndex:2267; }","duration":"136.011388ms","start":"2026-05-25T17:56:21.51846Z","end":"2026-05-25T17:56:21.654471Z","steps":["trace[1774986678] 'read index received' (duration: 10.658292ms)","trace[1774986678] 'applied index is now lower than readState.Index' (duration: 125.351456ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T17:56:21.654689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.200352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-25T17:56:21.654713Z","caller":"traceutil/trace.go:171","msg":"trace[2077215243] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"156.897004ms","start":"2026-05-25T17:56:21.49773Z","end":"2026-05-25T17:56:21.654627Z","steps":["trace[2077215243] 'process raft request' (duration: 156.589287ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T17:56:21.654782Z","caller":"traceutil/trace.go:171","msg":"trace[1540514581] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2185; }","duration":"136.350775ms","start":"2026-05-25T17:56:21.518415Z","end":"2026-05-25T17:56:21.654766Z","steps":["trace[1540514581] 'agreement among raft nodes before linearized reading' (duration: 136.202943ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T17:56:21.655116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.920224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-25T17:56:21.65536Z","caller":"traceutil/trace.go:171","msg":"trace[115939999] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:2185; }","duration":"103.029456ms","start":"2026-05-25T17:56:21.552145Z","end":"2026-05-25T17:56:21.655175Z","steps":["trace[115939999] 'agreement among raft nodes before linearized reading' (duration: 102.852843ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T17:56:56.470756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.575587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T17:56:56.470872Z","caller":"traceutil/trace.go:171","msg":"trace[243422319] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2549; }","duration":"137.761161ms","start":"2026-05-25T17:56:56.333087Z","end":"2026-05-25T17:56:56.470848Z","steps":["trace[243422319] 'range keys from in-memory index tree' (duration: 137.497406ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T17:57:30.173022Z","caller":"traceutil/trace.go:171","msg":"trace[133376839] transaction","detail":"{read_only:false; response_revision:2754; number_of_response:1; }","duration":"162.936301ms","start":"2026-05-25T17:57:30.010047Z","end":"2026-05-25T17:57:30.172983Z","steps":["trace[133376839] 'process raft request' (duration: 98.525017ms)","trace[133376839] 'compare' (duration: 64.265901ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T17:57:30.499186Z","caller":"traceutil/trace.go:171","msg":"trace[198129003] transaction","detail":"{read_only:false; response_revision:2756; number_of_response:1; }","duration":"112.151816ms","start":"2026-05-25T17:57:30.387001Z","end":"2026-05-25T17:57:30.499153Z","steps":["trace[198129003] 'process raft request' (duration: 111.9138ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T17:57:30.502947Z","caller":"traceutil/trace.go:171","msg":"trace[2054903355] transaction","detail":"{read_only:false; response_revision:2757; number_of_response:1; }","duration":"115.814432ms","start":"2026-05-25T17:57:30.387092Z","end":"2026-05-25T17:57:30.502906Z","steps":["trace[2054903355] 'process raft request' (duration: 115.67076ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T17:59:55.445179Z","caller":"traceutil/trace.go:171","msg":"trace[544349142] transaction","detail":"{read_only:false; response_revision:3717; number_of_response:1; }","duration":"249.115431ms","start":"2026-05-25T17:59:55.196032Z","end":"2026-05-25T17:59:55.445147Z","steps":["trace[544349142] 'process raft request' (duration: 248.911666ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T17:59:55.453382Z","caller":"traceutil/trace.go:171","msg":"trace[129223760] linearizableReadLoop","detail":"{readStateIndex:3861; appliedIndex:3858; }","duration":"215.505962ms","start":"2026-05-25T17:59:55.237854Z","end":"2026-05-25T17:59:55.45336Z","steps":["trace[129223760] 'read index received' (duration: 207.114747ms)","trace[129223760] 'applied index is now lower than readState.Index' (duration: 8.390415ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T17:59:55.453422Z","caller":"traceutil/trace.go:171","msg":"trace[1018066513] transaction","detail":"{read_only:false; response_revision:3718; number_of_response:1; }","duration":"254.145733ms","start":"2026-05-25T17:59:55.199258Z","end":"2026-05-25T17:59:55.453404Z","steps":["trace[1018066513] 'process raft request' (duration: 253.960929ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T17:59:55.453521Z","caller":"traceutil/trace.go:171","msg":"trace[790802210] transaction","detail":"{read_only:false; response_revision:3719; number_of_response:1; }","duration":"253.818608ms","start":"2026-05-25T17:59:55.199653Z","end":"2026-05-25T17:59:55.453471Z","steps":["trace[790802210] 'process raft request' (duration: 253.677284ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T17:59:55.45368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.804328ms","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-05-25T17:59:55.453725Z","caller":"traceutil/trace.go:171","msg":"trace[2105562579] range","detail":"{range_begin:/registry/masterleases/199.204.45.242; range_end:; response_count:1; response_revision:3719; }","duration":"215.869189ms","start":"2026-05-25T17:59:55.237847Z","end":"2026-05-25T17:59:55.453716Z","steps":["trace[2105562579] 'agreement among raft nodes before linearized reading' (duration: 215.635285ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:01:15.102047Z","caller":"traceutil/trace.go:171","msg":"trace[1230835116] transaction","detail":"{read_only:false; response_revision:4834; number_of_response:1; }","duration":"118.519901ms","start":"2026-05-25T18:01:14.983493Z","end":"2026-05-25T18:01:15.102013Z","steps":["trace[1230835116] 'process raft request' (duration: 118.216916ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:01:17.337925Z","caller":"traceutil/trace.go:171","msg":"trace[941956098] linearizableReadLoop","detail":"{readStateIndex:5065; appliedIndex:5064; }","duration":"244.04592ms","start":"2026-05-25T18:01:17.093863Z","end":"2026-05-25T18:01:17.337909Z","steps":["trace[941956098] 'read index received' (duration: 243.977449ms)","trace[941956098] 'applied index is now lower than readState.Index' (duration: 67.541µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T18:01:17.337975Z","caller":"traceutil/trace.go:171","msg":"trace[538939190] transaction","detail":"{read_only:false; response_revision:4878; number_of_response:1; }","duration":"285.336641ms","start":"2026-05-25T18:01:17.052606Z","end":"2026-05-25T18:01:17.337943Z","steps":["trace[538939190] 'process raft request' (duration: 285.176878ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T18:01:17.338095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.221243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-85364a0c-9e68-4157-a9a6-14a182c0785a\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-05-25T18:01:17.338127Z","caller":"traceutil/trace.go:171","msg":"trace[629038597] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-85364a0c-9e68-4157-a9a6-14a182c0785a; range_end:; response_count:1; response_revision:4878; }","duration":"244.316335ms","start":"2026-05-25T18:01:17.093801Z","end":"2026-05-25T18:01:17.338118Z","steps":["trace[629038597] 'agreement among raft nodes before linearized reading' (duration: 244.200103ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:01:17.352206Z","caller":"traceutil/trace.go:171","msg":"trace[1421618406] transaction","detail":"{read_only:false; response_revision:4879; number_of_response:1; }","duration":"244.249473ms","start":"2026-05-25T18:01:17.107929Z","end":"2026-05-25T18:01:17.352178Z","steps":["trace[1421618406] 'process raft request' (duration: 243.936758ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T18:01:17.352228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.939435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-25T18:01:17.352301Z","caller":"traceutil/trace.go:171","msg":"trace[7974464] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4879; }","duration":"240.045036ms","start":"2026-05-25T18:01:17.112239Z","end":"2026-05-25T18:01:17.352284Z","steps":["trace[7974464] 'agreement among raft nodes before linearized reading' (duration: 239.768431ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T18:01:17.352546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.256015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-85364a0c-9e68-4157-a9a6-14a182c0785a\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-05-25T18:01:17.352594Z","caller":"traceutil/trace.go:171","msg":"trace[1307459680] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-85364a0c-9e68-4157-a9a6-14a182c0785a; range_end:; response_count:1; response_revision:4879; }","duration":"150.358637ms","start":"2026-05-25T18:01:17.202223Z","end":"2026-05-25T18:01:17.352582Z","steps":["trace[1307459680] 'agreement among raft nodes before linearized reading' (duration: 149.852288ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:01:38.424604Z","caller":"traceutil/trace.go:171","msg":"trace[201624392] transaction","detail":"{read_only:false; response_revision:5285; number_of_response:1; }","duration":"115.310962ms","start":"2026-05-25T18:01:38.309261Z","end":"2026-05-25T18:01:38.424572Z","steps":["trace[201624392] 'process raft request' (duration: 115.085998ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:01:50.261521Z","caller":"traceutil/trace.go:171","msg":"trace[773035582] linearizableReadLoop","detail":"{readStateIndex:5665; appliedIndex:5664; }","duration":"223.403281ms","start":"2026-05-25T18:01:50.038093Z","end":"2026-05-25T18:01:50.261496Z","steps":["trace[773035582] 'read index received' (duration: 223.321209ms)","trace[773035582] 'applied index is now lower than readState.Index' (duration: 80.702µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T18:01:50.26164Z","caller":"traceutil/trace.go:171","msg":"trace[1042072305] transaction","detail":"{read_only:false; response_revision:5464; number_of_response:1; }","duration":"224.908629ms","start":"2026-05-25T18:01:50.036696Z","end":"2026-05-25T18:01:50.261605Z","steps":["trace[1042072305] 'process raft request' (duration: 224.635373ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T18:01:50.261781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.792056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9px5c\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-05-25T18:01:50.261821Z","caller":"traceutil/trace.go:171","msg":"trace[735231205] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9px5c; range_end:; response_count:1; response_revision:5464; }","duration":"218.865908ms","start":"2026-05-25T18:01:50.042944Z","end":"2026-05-25T18:01:50.26181Z","steps":["trace[735231205] 'agreement among raft nodes before linearized reading' (duration: 218.713605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T18:01:50.261865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.784858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-25T18:01:50.261872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.749928ms","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-05-25T18:01:50.261926Z","caller":"traceutil/trace.go:171","msg":"trace[406979647] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:5464; }","duration":"138.90968ms","start":"2026-05-25T18:01:50.123002Z","end":"2026-05-25T18:01:50.261912Z","steps":["trace[406979647] 'agreement among raft nodes before linearized reading' (duration: 138.740837ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:01:50.261982Z","caller":"traceutil/trace.go:171","msg":"trace[1829243134] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5464; }","duration":"223.91832ms","start":"2026-05-25T18:01:50.03804Z","end":"2026-05-25T18:01:50.261958Z","steps":["trace[1829243134] 'agreement among raft nodes before linearized reading' (duration: 223.589974ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:01:50.933845Z","caller":"traceutil/trace.go:171","msg":"trace[45666062] transaction","detail":"{read_only:false; response_revision:5471; number_of_response:1; }","duration":"158.526746ms","start":"2026-05-25T18:01:50.7753Z","end":"2026-05-25T18:01:50.933827Z","steps":["trace[45666062] 'process raft request' (duration: 59.356444ms)","trace[45666062] 'compare' (duration: 99.03717ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T18:01:50.934244Z","caller":"traceutil/trace.go:171","msg":"trace[1078264583] transaction","detail":"{read_only:false; response_revision:5472; number_of_response:1; }","duration":"151.083287ms","start":"2026-05-25T18:01:50.783117Z","end":"2026-05-25T18:01:50.9342Z","steps":["trace[1078264583] 'process raft request' (duration: 150.68042ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:02:29.24343Z","caller":"traceutil/trace.go:171","msg":"trace[1462296238] transaction","detail":"{read_only:false; response_revision:5804; number_of_response:1; }","duration":"100.557518ms","start":"2026-05-25T18:02:29.142835Z","end":"2026-05-25T18:02:29.243393Z","steps":["trace[1462296238] 'process raft request' (duration: 100.239583ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:03:12.269102Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2983} {"level":"info","ts":"2026-05-25T18:03:12.347414Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2983,"took":"76.049959ms","hash":359384837,"current-db-size-bytes":58920960,"current-db-size":"59 MB","current-db-size-in-use-bytes":34447360,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-05-25T18:03:12.347483Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":359384837,"revision":2983,"compact-revision":-1} {"level":"info","ts":"2026-05-25T18:07:51.808496Z","caller":"traceutil/trace.go:171","msg":"trace[233825046] linearizableReadLoop","detail":"{readStateIndex:8461; appliedIndex:8460; }","duration":"174.794341ms","start":"2026-05-25T18:07:51.633676Z","end":"2026-05-25T18:07:51.808471Z","steps":["trace[233825046] 'read index received' (duration: 174.634019ms)","trace[233825046] 'applied index is now lower than readState.Index' (duration: 159.302µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T18:07:51.80855Z","caller":"traceutil/trace.go:171","msg":"trace[1154080717] transaction","detail":"{read_only:false; response_revision:8171; number_of_response:1; }","duration":"228.543986ms","start":"2026-05-25T18:07:51.579977Z","end":"2026-05-25T18:07:51.808521Z","steps":["trace[1154080717] 'process raft request' (duration: 228.337053ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T18:07:51.808651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.954264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T18:07:51.808687Z","caller":"traceutil/trace.go:171","msg":"trace[27088343] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:8171; }","duration":"175.053746ms","start":"2026-05-25T18:07:51.633621Z","end":"2026-05-25T18:07:51.808675Z","steps":["trace[27088343] 'agreement among raft nodes before linearized reading' (duration: 174.973635ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:07:52.559941Z","caller":"traceutil/trace.go:171","msg":"trace[1629027074] linearizableReadLoop","detail":"{readStateIndex:8468; appliedIndex:8467; }","duration":"101.360745ms","start":"2026-05-25T18:07:52.458553Z","end":"2026-05-25T18:07:52.559914Z","steps":["trace[1629027074] 'read index received' (duration: 68.578225ms)","trace[1629027074] 'applied index is now lower than readState.Index' (duration: 32.78145ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T18:07:52.560036Z","caller":"traceutil/trace.go:171","msg":"trace[1159022883] transaction","detail":"{read_only:false; response_revision:8178; number_of_response:1; }","duration":"102.545297ms","start":"2026-05-25T18:07:52.457444Z","end":"2026-05-25T18:07:52.559989Z","steps":["trace[1159022883] 'process raft request' (duration: 69.675886ms)","trace[1159022883] 'compare' (duration: 32.627456ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T18:07:52.560534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.955215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:224125"} {"level":"info","ts":"2026-05-25T18:07:52.5606Z","caller":"traceutil/trace.go:171","msg":"trace[991879] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8178; }","duration":"102.051548ms","start":"2026-05-25T18:07:52.458529Z","end":"2026-05-25T18:07:52.56058Z","steps":["trace[991879] 'agreement among raft nodes before linearized reading' (duration: 101.555889ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:07:52.704478Z","caller":"traceutil/trace.go:171","msg":"trace[942119019] transaction","detail":"{read_only:false; response_revision:8180; number_of_response:1; }","duration":"112.939163ms","start":"2026-05-25T18:07:52.591505Z","end":"2026-05-25T18:07:52.704445Z","steps":["trace[942119019] 'process raft request' (duration: 73.975347ms)","trace[942119019] 'compare' (duration: 38.758902ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T18:07:52.96335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.48925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T18:07:52.963439Z","caller":"traceutil/trace.go:171","msg":"trace[1083402800] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8180; }","duration":"143.586972ms","start":"2026-05-25T18:07:52.819829Z","end":"2026-05-25T18:07:52.963416Z","steps":["trace[1083402800] 'range keys from in-memory index tree' (duration: 143.426779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T18:07:52.963447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.18812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T18:07:52.96355Z","caller":"traceutil/trace.go:171","msg":"trace[787981271] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:8180; }","duration":"120.320622ms","start":"2026-05-25T18:07:52.843205Z","end":"2026-05-25T18:07:52.963526Z","steps":["trace[787981271] 'range keys from in-memory index tree' (duration: 120.129549ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T18:07:52.963705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.906478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-25T18:07:52.963783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.460985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T18:07:52.963787Z","caller":"traceutil/trace.go:171","msg":"trace[2084903083] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8180; }","duration":"145.02386ms","start":"2026-05-25T18:07:52.818746Z","end":"2026-05-25T18:07:52.963769Z","steps":["trace[2084903083] 'range keys from in-memory index tree' (duration: 144.810966ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:07:52.963823Z","caller":"traceutil/trace.go:171","msg":"trace[1026503952] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:8180; }","duration":"120.546376ms","start":"2026-05-25T18:07:52.843265Z","end":"2026-05-25T18:07:52.963812Z","steps":["trace[1026503952] 'count revisions from in-memory index tree' (duration: 120.373493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T18:07:52.963818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.87895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-25T18:07:52.963875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.874205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T18:07:52.963904Z","caller":"traceutil/trace.go:171","msg":"trace[1850999609] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:8180; }","duration":"105.030194ms","start":"2026-05-25T18:07:52.858852Z","end":"2026-05-25T18:07:52.963883Z","steps":["trace[1850999609] 'count revisions from in-memory index tree' (duration: 104.758459ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:07:52.963949Z","caller":"traceutil/trace.go:171","msg":"trace[586712062] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:8180; }","duration":"119.971226ms","start":"2026-05-25T18:07:52.84396Z","end":"2026-05-25T18:07:52.963932Z","steps":["trace[586712062] 'range keys from in-memory index tree' (duration: 119.756803ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T18:07:52.963577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.568361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T18:07:52.964089Z","caller":"traceutil/trace.go:171","msg":"trace[1595600478] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8180; }","duration":"145.322555ms","start":"2026-05-25T18:07:52.818755Z","end":"2026-05-25T18:07:52.964078Z","steps":["trace[1595600478] 'count revisions from in-memory index tree' (duration: 144.362528ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:08:12.275885Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6117} {"level":"info","ts":"2026-05-25T18:08:12.385446Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6117,"took":"107.388177ms","hash":248414892,"current-db-size-bytes":58920960,"current-db-size":"59 MB","current-db-size-in-use-bytes":23126016,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-05-25T18:08:12.385513Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":248414892,"revision":6117,"compact-revision":2983} {"level":"info","ts":"2026-05-25T18:08:19.218863Z","caller":"traceutil/trace.go:171","msg":"trace[364062667] transaction","detail":"{read_only:false; response_revision:8377; number_of_response:1; }","duration":"164.605849ms","start":"2026-05-25T18:08:19.054232Z","end":"2026-05-25T18:08:19.218838Z","steps":["trace[364062667] 'process raft request' (duration: 164.451506ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:08:23.097182Z","caller":"traceutil/trace.go:171","msg":"trace[1677657542] linearizableReadLoop","detail":"{readStateIndex:8696; appliedIndex:8695; }","duration":"106.318468ms","start":"2026-05-25T18:08:22.990832Z","end":"2026-05-25T18:08:23.09715Z","steps":["trace[1677657542] 'read index received' (duration: 105.108215ms)","trace[1677657542] 'applied index is now lower than readState.Index' (duration: 1.209373ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T18:08:23.097321Z","caller":"traceutil/trace.go:171","msg":"trace[626610269] transaction","detail":"{read_only:false; response_revision:8397; number_of_response:1; }","duration":"179.53429ms","start":"2026-05-25T18:08:22.917766Z","end":"2026-05-25T18:08:23.0973Z","steps":["trace[626610269] 'process raft request' (duration: 178.585812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T18:08:23.097352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.501752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-25T18:08:23.097397Z","caller":"traceutil/trace.go:171","msg":"trace[982562628] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:8397; }","duration":"106.594553ms","start":"2026-05-25T18:08:22.990786Z","end":"2026-05-25T18:08:23.097381Z","steps":["trace[982562628] 'agreement among raft nodes before linearized reading' (duration: 106.484791ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:09:18.788571Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002400.wal"} {"level":"info","ts":"2026-05-25T18:09:47.264365Z","caller":"traceutil/trace.go:171","msg":"trace[574299187] transaction","detail":"{read_only:false; response_revision:9227; number_of_response:1; }","duration":"112.997073ms","start":"2026-05-25T18:09:47.151198Z","end":"2026-05-25T18:09:47.264195Z","steps":["trace[574299187] 'process raft request' (duration: 104.84521ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:10:49.029627Z","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-05-25T18:10:49.035712Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-25T18:10:49.035834Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-25T18:13:12.282931Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8290} {"level":"info","ts":"2026-05-25T18:13:12.360719Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8290,"took":"75.327802ms","hash":1050604765,"current-db-size-bytes":58920960,"current-db-size":"59 MB","current-db-size-in-use-bytes":26673152,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-05-25T18:13:12.360791Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1050604765,"revision":8290,"compact-revision":6117} {"level":"info","ts":"2026-05-25T18:13:29.895546Z","caller":"traceutil/trace.go:171","msg":"trace[1567596961] transaction","detail":"{read_only:false; response_revision:11063; number_of_response:1; }","duration":"198.401686ms","start":"2026-05-25T18:13:29.697122Z","end":"2026-05-25T18:13:29.895523Z","steps":["trace[1567596961] 'process raft request' (duration: 198.252692ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:13:29.955295Z","caller":"traceutil/trace.go:171","msg":"trace[842705651] linearizableReadLoop","detail":"{readStateIndex:11441; appliedIndex:11439; }","duration":"214.367717ms","start":"2026-05-25T18:13:29.740895Z","end":"2026-05-25T18:13:29.955263Z","steps":["trace[842705651] 'read index received' (duration: 154.504697ms)","trace[842705651] 'applied index is now lower than readState.Index' (duration: 59.86217ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T18:13:29.955394Z","caller":"traceutil/trace.go:171","msg":"trace[1677176896] transaction","detail":"{read_only:false; response_revision:11064; number_of_response:1; }","duration":"255.376521ms","start":"2026-05-25T18:13:29.699974Z","end":"2026-05-25T18:13:29.955351Z","steps":["trace[1677176896] 'process raft request' (duration: 255.143227ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T18:13:29.955435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.52098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T18:13:29.955721Z","caller":"traceutil/trace.go:171","msg":"trace[895610740] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:11064; }","duration":"214.844337ms","start":"2026-05-25T18:13:29.74085Z","end":"2026-05-25T18:13:29.955694Z","steps":["trace[895610740] 'agreement among raft nodes before linearized reading' (duration: 214.5154ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:18:12.292038Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10969} {"level":"info","ts":"2026-05-25T18:18:12.383136Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10969,"took":"88.435139ms","hash":2978406208,"current-db-size-bytes":58920960,"current-db-size":"59 MB","current-db-size-in-use-bytes":27942912,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-25T18:18:12.383197Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2978406208,"revision":10969,"compact-revision":8290} {"level":"info","ts":"2026-05-25T18:20:06.60539Z","caller":"traceutil/trace.go:171","msg":"trace[1593193270] linearizableReadLoop","detail":"{readStateIndex:14189; appliedIndex:14188; }","duration":"346.056701ms","start":"2026-05-25T18:20:06.259279Z","end":"2026-05-25T18:20:06.605336Z","steps":["trace[1593193270] 'read index received' (duration: 345.713915ms)","trace[1593193270] 'applied index is now lower than readState.Index' (duration: 341.546µs)"],"step_count":2} {"level":"info","ts":"2026-05-25T18:20:06.605481Z","caller":"traceutil/trace.go:171","msg":"trace[955240272] transaction","detail":"{read_only:false; response_revision:13717; number_of_response:1; }","duration":"395.827181ms","start":"2026-05-25T18:20:06.209623Z","end":"2026-05-25T18:20:06.60545Z","steps":["trace[955240272] 'process raft request' (duration: 395.514936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T18:20:06.605663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T18:20:06.209606Z","time spent":"395.962194ms","remote":"127.0.0.1:41398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T18:20:06.606234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.935557ms","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-05-25T18:20:06.606423Z","caller":"traceutil/trace.go:171","msg":"trace[942594903] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:13717; }","duration":"347.04317ms","start":"2026-05-25T18:20:06.259236Z","end":"2026-05-25T18:20:06.60628Z","steps":["trace[942594903] 'agreement among raft nodes before linearized reading' (duration: 346.258685ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T18:20:06.606605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T18:20:06.259221Z","time spent":"347.251304ms","remote":"127.0.0.1:41398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-25T18:20:06.630505Z","caller":"traceutil/trace.go:171","msg":"trace[2076983627] transaction","detail":"{read_only:false; response_revision:13718; number_of_response:1; }","duration":"130.259539ms","start":"2026-05-25T18:20:06.500195Z","end":"2026-05-25T18:20:06.630454Z","steps":["trace[2076983627] 'process raft request' (duration: 130.153277ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T18:20:06.630678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.336176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1986"} {"level":"info","ts":"2026-05-25T18:20:06.630762Z","caller":"traceutil/trace.go:171","msg":"trace[1648450100] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:13718; }","duration":"311.48207ms","start":"2026-05-25T18:20:06.319261Z","end":"2026-05-25T18:20:06.630743Z","steps":["trace[1648450100] 'agreement among raft nodes before linearized reading' (duration: 311.234395ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T18:20:06.630794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T18:20:06.319237Z","time spent":"311.551001ms","remote":"127.0.0.1:41342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2009,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-05-25T18:20:28.198604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.690005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-25T18:20:28.198663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.357721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c48a7550-d843-47f0-bab9-392c830a1995\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-05-25T18:20:28.198752Z","caller":"traceutil/trace.go:171","msg":"trace[403807693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14021; }","duration":"309.890529ms","start":"2026-05-25T18:20:27.888819Z","end":"2026-05-25T18:20:28.198709Z","steps":["trace[403807693] 'range keys from in-memory index tree' (duration: 309.565303ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:20:28.198696Z","caller":"traceutil/trace.go:171","msg":"trace[814979901] linearizableReadLoop","detail":"{readStateIndex:14509; appliedIndex:14508; }","duration":"206.993937ms","start":"2026-05-25T18:20:27.991668Z","end":"2026-05-25T18:20:28.198662Z","steps":["trace[814979901] 'read index received' (duration: 134.204843ms)","trace[814979901] 'applied index is now lower than readState.Index' (duration: 72.787674ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T18:20:28.198786Z","caller":"traceutil/trace.go:171","msg":"trace[637168787] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c48a7550-d843-47f0-bab9-392c830a1995; range_end:; response_count:1; response_revision:14021; }","duration":"360.560595ms","start":"2026-05-25T18:20:27.838201Z","end":"2026-05-25T18:20:28.198762Z","steps":["trace[637168787] 'range keys from in-memory index tree' (duration: 360.166917ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T18:20:28.198795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T18:20:27.888794Z","time spent":"309.99034ms","remote":"127.0.0.1:41144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-25T18:20:28.198823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T18:20:27.838174Z","time spent":"360.642157ms","remote":"127.0.0.1:41328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3660,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c48a7550-d843-47f0-bab9-392c830a1995\" "} {"level":"warn","ts":"2026-05-25T18:20:28.198941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.279183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c48a7550-d843-47f0-bab9-392c830a1995\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-05-25T18:20:28.198988Z","caller":"traceutil/trace.go:171","msg":"trace[832464362] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c48a7550-d843-47f0-bab9-392c830a1995; range_end:; response_count:1; response_revision:14022; }","duration":"207.380565ms","start":"2026-05-25T18:20:27.991591Z","end":"2026-05-25T18:20:28.198971Z","steps":["trace[832464362] 'agreement among raft nodes before linearized reading' (duration: 207.196261ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:20:28.199076Z","caller":"traceutil/trace.go:171","msg":"trace[1739968679] transaction","detail":"{read_only:false; response_revision:14022; number_of_response:1; }","duration":"211.210226ms","start":"2026-05-25T18:20:27.987808Z","end":"2026-05-25T18:20:28.199018Z","steps":["trace[1739968679] 'process raft request' (duration: 138.063185ms)","trace[1739968679] 'compare' (duration: 72.418597ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T18:21:44.815082Z","caller":"traceutil/trace.go:171","msg":"trace[796277291] transaction","detail":"{read_only:false; response_revision:14785; number_of_response:1; }","duration":"119.18818ms","start":"2026-05-25T18:21:44.695867Z","end":"2026-05-25T18:21:44.815055Z","steps":["trace[796277291] 'process raft request' (duration: 118.995786ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T18:23:12.298885Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13002} {"level":"info","ts":"2026-05-25T18:23:12.38501Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13002,"took":"79.843668ms","hash":1533860991,"current-db-size-bytes":58920960,"current-db-size":"59 MB","current-db-size-in-use-bytes":31137792,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-25T18:23:12.385063Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1533860991,"revision":13002,"compact-revision":10969} {"level":"info","ts":"2026-05-25T18:28:12.305619Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15346} {"level":"info","ts":"2026-05-25T18:28:12.396619Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15346,"took":"88.085787ms","hash":2256915314,"current-db-size-bytes":58920960,"current-db-size":"59 MB","current-db-size-in-use-bytes":31162368,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-25T18:28:12.396699Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2256915314,"revision":15346,"compact-revision":13002} {"level":"info","ts":"2026-05-25T18:33:12.315777Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17556} {"level":"info","ts":"2026-05-25T18:33:12.421911Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17556,"took":"102.758193ms","hash":3446439321,"current-db-size-bytes":58920960,"current-db-size":"59 MB","current-db-size-in-use-bytes":25210880,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-05-25T18:33:12.421985Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3446439321,"revision":17556,"compact-revision":15346} {"level":"info","ts":"2026-05-25T18:33:53.032417Z","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-05-25T18:33:53.03728Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-05-25T18:33:53.037367Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}