{"level":"warn","ts":"2026-09-11T17:22:33.982383Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-11T17:22:33.982476Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.208: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://162.253.55.208:2380","--initial-cluster=instance=https://162.253.55.208:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.208:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.208: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-09-11T17:22:33.982609Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-11T17:22:33.982624Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.208:2380"]} {"level":"info","ts":"2026-09-11T17:22:33.982684Z","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-09-11T17:22:33.983567Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.208:2379"]} {"level":"info","ts":"2026-09-11T17:22:33.983756Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.208:2380"],"listen-peer-urls":["https://162.253.55.208:2380"],"advertise-client-urls":["https://162.253.55.208:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.208:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.208: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-09-11T17:22:33.989445Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.372305ms"} {"level":"info","ts":"2026-09-11T17:22:34.000593Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5019b1666ea94ec4","cluster-id":"5aff54f2fc6d3e3d"} {"level":"info","ts":"2026-09-11T17:22:34.000678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 switched to configuration voters=()"} {"level":"info","ts":"2026-09-11T17:22:34.000699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became follower at term 0"} {"level":"info","ts":"2026-09-11T17:22:34.000711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5019b1666ea94ec4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-11T17:22:34.000722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became follower at term 1"} {"level":"info","ts":"2026-09-11T17:22:34.000765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 switched to configuration voters=(5771839450953371332)"} {"level":"warn","ts":"2026-09-11T17:22:34.008295Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-11T17:22:34.009827Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-11T17:22:34.010879Z","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-09-11T17:22:34.014212Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5019b1666ea94ec4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-11T17:22:34.015874Z","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-09-11T17:22:34.015944Z","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-09-11T17:22:34.015954Z","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-09-11T17:22:34.016744Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5019b1666ea94ec4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-11T17:22:34.019146Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 switched to configuration voters=(5771839450953371332)"} {"level":"info","ts":"2026-09-11T17:22:34.019234Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5aff54f2fc6d3e3d","local-member-id":"5019b1666ea94ec4","added-peer-id":"5019b1666ea94ec4","added-peer-peer-urls":["https://162.253.55.208:2380"]} {"level":"info","ts":"2026-09-11T17:22:34.020398Z","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-09-11T17:22:34.020595Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5019b1666ea94ec4","initial-advertise-peer-urls":["https://162.253.55.208:2380"],"listen-peer-urls":["https://162.253.55.208:2380"],"advertise-client-urls":["https://162.253.55.208:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.208:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-11T17:22:34.020654Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-11T17:22:34.021022Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.208:2380"} {"level":"info","ts":"2026-09-11T17:22:34.02107Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.208:2380"} {"level":"info","ts":"2026-09-11T17:22:34.201389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 is starting a new election at term 1"} {"level":"info","ts":"2026-09-11T17:22:34.201453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-11T17:22:34.201474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 received MsgPreVoteResp from 5019b1666ea94ec4 at term 1"} {"level":"info","ts":"2026-09-11T17:22:34.201508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became candidate at term 2"} {"level":"info","ts":"2026-09-11T17:22:34.201519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 received MsgVoteResp from 5019b1666ea94ec4 at term 2"} {"level":"info","ts":"2026-09-11T17:22:34.201534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became leader at term 2"} {"level":"info","ts":"2026-09-11T17:22:34.201547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5019b1666ea94ec4 elected leader 5019b1666ea94ec4 at term 2"} {"level":"info","ts":"2026-09-11T17:22:34.204171Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-11T17:22:34.204931Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-11T17:22:34.20495Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-11T17:22:34.205222Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-11T17:22:34.205273Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-11T17:22:34.205338Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5019b1666ea94ec4","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.208:2379]}","request-path":"/0/members/5019b1666ea94ec4/attributes","cluster-id":"5aff54f2fc6d3e3d","publish-timeout":"7s"} {"level":"info","ts":"2026-09-11T17:22:34.205354Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5aff54f2fc6d3e3d","local-member-id":"5019b1666ea94ec4","cluster-version":"3.5"} {"level":"info","ts":"2026-09-11T17:22:34.205419Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-11T17:22:34.20544Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-11T17:22:34.207183Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-11T17:22:34.214279Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.208:2379"} {"level":"info","ts":"2026-09-11T17:22:37.526299Z","caller":"traceutil/trace.go:171","msg":"trace[381201152] transaction","detail":"{read_only:false; response_revision:188; number_of_response:1; }","duration":"575.333944ms","start":"2026-09-11T17:22:36.950938Z","end":"2026-09-11T17:22:37.526272Z","steps":["trace[381201152] 'process raft request' (duration: 575.087471ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:22:37.526986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:22:36.950924Z","time spent":"575.457765ms","remote":"127.0.0.1:37754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":750,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-11T17:22:37.760329Z","caller":"traceutil/trace.go:171","msg":"trace[416149284] linearizableReadLoop","detail":"{readStateIndex:194; appliedIndex:193; }","duration":"133.032367ms","start":"2026-09-11T17:22:37.627274Z","end":"2026-09-11T17:22:37.760306Z","steps":["trace[416149284] 'read index received' (duration: 55.491887ms)","trace[416149284] 'applied index is now lower than readState.Index' (duration: 77.53919ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T17:22:37.760497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.202558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T17:22:37.76055Z","caller":"traceutil/trace.go:171","msg":"trace[1623205195] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:189; }","duration":"133.295599ms","start":"2026-09-11T17:22:37.627228Z","end":"2026-09-11T17:22:37.760523Z","steps":["trace[1623205195] 'agreement among raft nodes before linearized reading' (duration: 133.160108ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:22:37.76076Z","caller":"traceutil/trace.go:171","msg":"trace[617159808] transaction","detail":"{read_only:false; response_revision:189; number_of_response:1; }","duration":"229.011551ms","start":"2026-09-11T17:22:37.531718Z","end":"2026-09-11T17:22:37.76073Z","steps":["trace[617159808] 'process raft request' (duration: 151.035667ms)","trace[617159808] 'compare' (duration: 77.434508ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:23:15.829775Z","caller":"traceutil/trace.go:171","msg":"trace[716028672] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"117.996913ms","start":"2026-09-11T17:23:15.711756Z","end":"2026-09-11T17:23:15.829752Z","steps":["trace[716028672] 'process raft request' (duration: 117.875708ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:23:15.835147Z","caller":"traceutil/trace.go:171","msg":"trace[1993954546] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"123.294233ms","start":"2026-09-11T17:23:15.711834Z","end":"2026-09-11T17:23:15.835128Z","steps":["trace[1993954546] 'process raft request' (duration: 122.117414ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:23:15.835251Z","caller":"traceutil/trace.go:171","msg":"trace[1668410544] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"113.498516ms","start":"2026-09-11T17:23:15.721744Z","end":"2026-09-11T17:23:15.835243Z","steps":["trace[1668410544] 'process raft request' (duration: 112.269175ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:23:15.835362Z","caller":"traceutil/trace.go:171","msg":"trace[101335741] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"101.008906ms","start":"2026-09-11T17:23:15.734344Z","end":"2026-09-11T17:23:15.835353Z","steps":["trace[101335741] 'process raft request' (duration: 99.704191ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:23:16.064882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.309484ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:10514"} {"level":"info","ts":"2026-09-11T17:23:16.065114Z","caller":"traceutil/trace.go:171","msg":"trace[1206655830] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"151.48314ms","start":"2026-09-11T17:23:15.913607Z","end":"2026-09-11T17:23:16.06509Z","steps":["trace[1206655830] 'process raft request' (duration: 151.390667ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:23:16.065181Z","caller":"traceutil/trace.go:171","msg":"trace[2006630388] transaction","detail":"{read_only:false; number_of_response:1; response_revision:561; }","duration":"159.901101ms","start":"2026-09-11T17:23:15.905199Z","end":"2026-09-11T17:23:16.065101Z","steps":["trace[2006630388] 'process raft request' (duration: 14.011173ms)","trace[2006630388] 'compare' (duration: 145.227821ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:23:16.08395Z","caller":"traceutil/trace.go:171","msg":"trace[1558693501] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"161.814703ms","start":"2026-09-11T17:23:15.922105Z","end":"2026-09-11T17:23:16.08392Z","steps":["trace[1558693501] 'process raft request' (duration: 161.5046ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:23:16.08412Z","caller":"traceutil/trace.go:171","msg":"trace[865370560] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"161.688198ms","start":"2026-09-11T17:23:15.92241Z","end":"2026-09-11T17:23:16.084098Z","steps":["trace[865370560] 'process raft request' (duration: 161.582444ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:23:16.084302Z","caller":"traceutil/trace.go:171","msg":"trace[1988202860] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"162.106944ms","start":"2026-09-11T17:23:15.922173Z","end":"2026-09-11T17:23:16.08428Z","steps":["trace[1988202860] 'process raft request' (duration: 161.597934ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:23:16.091913Z","caller":"traceutil/trace.go:171","msg":"trace[341433096] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"130.719634ms","start":"2026-09-11T17:23:15.961163Z","end":"2026-09-11T17:23:16.091883Z","steps":["trace[341433096] 'process raft request' (duration: 129.937072ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:23:19.203652Z","caller":"traceutil/trace.go:171","msg":"trace[519969808] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"263.35055ms","start":"2026-09-11T17:23:18.93974Z","end":"2026-09-11T17:23:19.203091Z","steps":["trace[519969808] 'process raft request' (duration: 262.60571ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:23:19.763194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.351692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T17:23:19.763284Z","caller":"traceutil/trace.go:171","msg":"trace[1693614316] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:625; }","duration":"488.494188ms","start":"2026-09-11T17:23:19.274768Z","end":"2026-09-11T17:23:19.763262Z","steps":["trace[1693614316] 'range keys from in-memory index tree' (duration: 488.257558ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:23:19.763341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:23:19.274745Z","time spent":"488.586931ms","remote":"127.0.0.1:37600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-09-11T17:23:19.763416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.140654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-11T17:23:19.763525Z","caller":"traceutil/trace.go:171","msg":"trace[860630950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:625; }","duration":"483.351763ms","start":"2026-09-11T17:23:19.280145Z","end":"2026-09-11T17:23:19.763496Z","steps":["trace[860630950] 'range keys from in-memory index tree' (duration: 482.891185ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:23:19.763585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:23:19.280113Z","time spent":"483.457177ms","remote":"127.0.0.1:37674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-11T17:23:23.336682Z","caller":"traceutil/trace.go:171","msg":"trace[1217792593] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"212.20307ms","start":"2026-09-11T17:23:23.124424Z","end":"2026-09-11T17:23:23.336627Z","steps":["trace[1217792593] 'process raft request' (duration: 211.471892ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:23:23.336766Z","caller":"traceutil/trace.go:171","msg":"trace[1545451471] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:675; }","duration":"197.129414ms","start":"2026-09-11T17:23:23.139574Z","end":"2026-09-11T17:23:23.336703Z","steps":["trace[1545451471] 'read index received' (duration: 195.908067ms)","trace[1545451471] 'applied index is now lower than readState.Index' (duration: 1.168885ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T17:23:23.33693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.29853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5n6rl\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-11T17:23:23.337037Z","caller":"traceutil/trace.go:171","msg":"trace[6039001] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5n6rl; range_end:; response_count:1; response_revision:650; }","duration":"197.472097ms","start":"2026-09-11T17:23:23.139543Z","end":"2026-09-11T17:23:23.337015Z","steps":["trace[6039001] 'agreement among raft nodes before linearized reading' (duration: 197.215447ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:23:24.137744Z","caller":"traceutil/trace.go:171","msg":"trace[1973462947] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"774.238336ms","start":"2026-09-11T17:23:23.363481Z","end":"2026-09-11T17:23:24.13772Z","steps":["trace[1973462947] 'process raft request' (duration: 773.932544ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:23:24.137938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:23:23.363457Z","time spent":"774.406792ms","remote":"127.0.0.1:37584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-11T17:23:24.148432Z","caller":"traceutil/trace.go:171","msg":"trace[177666466] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"729.808693ms","start":"2026-09-11T17:23:23.418592Z","end":"2026-09-11T17:23:24.148401Z","steps":["trace[177666466] 'process raft request' (duration: 729.588535ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:23:24.148601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:23:23.418569Z","time spent":"729.96579ms","remote":"127.0.0.1:37642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-11T17:23:24.166578Z","caller":"traceutil/trace.go:171","msg":"trace[2110160808] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:676; }","duration":"365.379279ms","start":"2026-09-11T17:23:23.801169Z","end":"2026-09-11T17:23:24.166548Z","steps":["trace[2110160808] 'read index received' (duration: 336.0574ms)","trace[2110160808] 'applied index is now lower than readState.Index' (duration: 29.320109ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T17:23:24.166872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.688091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-11T17:23:24.166914Z","caller":"traceutil/trace.go:171","msg":"trace[1635129422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:652; }","duration":"365.793356ms","start":"2026-09-11T17:23:23.80111Z","end":"2026-09-11T17:23:24.166903Z","steps":["trace[1635129422] 'agreement among raft nodes before linearized reading' (duration: 365.604309ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:23:24.166952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:23:23.801066Z","time spent":"365.877459ms","remote":"127.0.0.1:37674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-11T17:23:41.061034Z","caller":"traceutil/trace.go:171","msg":"trace[1184980143] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"137.281397ms","start":"2026-09-11T17:23:40.923724Z","end":"2026-09-11T17:23:41.061006Z","steps":["trace[1184980143] 'process raft request' (duration: 137.07225ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:23:41.293579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.05336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T17:23:41.293674Z","caller":"traceutil/trace.go:171","msg":"trace[995867380] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:820; }","duration":"186.215995ms","start":"2026-09-11T17:23:41.107436Z","end":"2026-09-11T17:23:41.293652Z","steps":["trace[995867380] 'range keys from in-memory index tree' (duration: 185.977097ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:24:12.005307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.909663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-11T17:24:12.0054Z","caller":"traceutil/trace.go:171","msg":"trace[1200166622] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1222; }","duration":"242.045336ms","start":"2026-09-11T17:24:11.763336Z","end":"2026-09-11T17:24:12.005382Z","steps":["trace[1200166622] 'count revisions from in-memory index tree' (duration: 241.499903ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:24:41.432658Z","caller":"traceutil/trace.go:171","msg":"trace[758519928] transaction","detail":"{read_only:false; response_revision:1543; number_of_response:1; }","duration":"101.0274ms","start":"2026-09-11T17:24:41.331599Z","end":"2026-09-11T17:24:41.432626Z","steps":["trace[758519928] 'process raft request' (duration: 100.886057ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:24:42.66792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.484678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/topicpermissions.rabbitmq.com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T17:24:42.668055Z","caller":"traceutil/trace.go:171","msg":"trace[1367699775] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/topicpermissions.rabbitmq.com; range_end:; response_count:0; response_revision:1572; }","duration":"253.638641ms","start":"2026-09-11T17:24:42.414357Z","end":"2026-09-11T17:24:42.667996Z","steps":["trace[1367699775] 'range keys from in-memory index tree' (duration: 253.404506ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:24:42.668834Z","caller":"traceutil/trace.go:171","msg":"trace[2000195905] transaction","detail":"{read_only:false; response_revision:1573; number_of_response:1; }","duration":"252.57952ms","start":"2026-09-11T17:24:42.415947Z","end":"2026-09-11T17:24:42.668526Z","steps":["trace[2000195905] 'process raft request' (duration: 226.076379ms)","trace[2000195905] 'compare' (duration: 25.829828ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:25:04.007017Z","caller":"traceutil/trace.go:171","msg":"trace[663296897] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"316.213993ms","start":"2026-09-11T17:25:03.690779Z","end":"2026-09-11T17:25:04.006993Z","steps":["trace[663296897] 'process raft request' (duration: 316.04725ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:25:04.007152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:25:03.69072Z","time spent":"316.363686ms","remote":"127.0.0.1:37584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10932,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-11T17:25:04.158502Z","caller":"traceutil/trace.go:171","msg":"trace[1129567372] transaction","detail":"{read_only:false; response_revision:1900; number_of_response:1; }","duration":"144.812514ms","start":"2026-09-11T17:25:04.013656Z","end":"2026-09-11T17:25:04.158469Z","steps":["trace[1129567372] 'process raft request' (duration: 136.010707ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:04.158804Z","caller":"traceutil/trace.go:171","msg":"trace[1886831088] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"143.92543ms","start":"2026-09-11T17:25:04.014863Z","end":"2026-09-11T17:25:04.158788Z","steps":["trace[1886831088] 'process raft request' (duration: 143.531783ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:04.158991Z","caller":"traceutil/trace.go:171","msg":"trace[551109817] transaction","detail":"{read_only:false; response_revision:1902; number_of_response:1; }","duration":"144.036251ms","start":"2026-09-11T17:25:04.014931Z","end":"2026-09-11T17:25:04.158968Z","steps":["trace[551109817] 'process raft request' (duration: 143.617334ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:04.159296Z","caller":"traceutil/trace.go:171","msg":"trace[1148464078] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"139.073453ms","start":"2026-09-11T17:25:04.020212Z","end":"2026-09-11T17:25:04.159285Z","steps":["trace[1148464078] 'process raft request' (duration: 138.578033ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:53.006354Z","caller":"traceutil/trace.go:171","msg":"trace[782349617] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"101.097803ms","start":"2026-09-11T17:25:52.905219Z","end":"2026-09-11T17:25:53.006316Z","steps":["trace[782349617] 'process raft request' (duration: 100.86744ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:25:53.324071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.574611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-11T17:25:53.324354Z","caller":"traceutil/trace.go:171","msg":"trace[146527707] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2215; }","duration":"180.908856ms","start":"2026-09-11T17:25:53.143422Z","end":"2026-09-11T17:25:53.324331Z","steps":["trace[146527707] 'range keys from in-memory index tree' (duration: 180.301947ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:53.459407Z","caller":"traceutil/trace.go:171","msg":"trace[1796840256] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"315.914169ms","start":"2026-09-11T17:25:53.143454Z","end":"2026-09-11T17:25:53.459368Z","steps":["trace[1796840256] 'process raft request' (duration: 315.704775ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:25:53.459666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:25:53.14343Z","time spent":"316.089642ms","remote":"127.0.0.1:37674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-11T17:25:53.515396Z","caller":"traceutil/trace.go:171","msg":"trace[475852970] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"334.969978ms","start":"2026-09-11T17:25:53.180371Z","end":"2026-09-11T17:25:53.515341Z","steps":["trace[475852970] 'process raft request' (duration: 334.668652ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:25:53.515933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:25:53.180333Z","time spent":"335.350923ms","remote":"127.0.0.1:37674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-11T17:25:53.845359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.152094ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-09-11T17:25:53.845978Z","caller":"traceutil/trace.go:171","msg":"trace[1944908036] transaction","detail":"{read_only:false; response_revision:2218; number_of_response:1; }","duration":"515.790523ms","start":"2026-09-11T17:25:53.330147Z","end":"2026-09-11T17:25:53.845937Z","steps":["trace[1944908036] 'process raft request' (duration: 515.395707ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:53.846133Z","caller":"traceutil/trace.go:171","msg":"trace[613785936] transaction","detail":"{read_only:false; response_revision:2219; number_of_response:1; }","duration":"256.175055ms","start":"2026-09-11T17:25:53.589752Z","end":"2026-09-11T17:25:53.845927Z","steps":["trace[613785936] 'process raft request' (duration: 256.104764ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:53.84619Z","caller":"traceutil/trace.go:171","msg":"trace[2013475152] linearizableReadLoop","detail":"{readStateIndex:2305; appliedIndex:2303; }","duration":"641.402033ms","start":"2026-09-11T17:25:53.204762Z","end":"2026-09-11T17:25:53.846164Z","steps":["trace[2013475152] 'read index received' (duration: 254.375967ms)","trace[2013475152] 'applied index is now lower than readState.Index' (duration: 387.024186ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T17:25:53.846388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.613215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-09-11T17:25:53.846512Z","caller":"traceutil/trace.go:171","msg":"trace[1258005384] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2219; }","duration":"641.792198ms","start":"2026-09-11T17:25:53.204705Z","end":"2026-09-11T17:25:53.846497Z","steps":["trace[1258005384] 'agreement among raft nodes before linearized reading' (duration: 641.526114ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:25:53.846552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:25:53.204682Z","time spent":"641.859409ms","remote":"127.0.0.1:37674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-11T17:25:53.846716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.022187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-11T17:25:53.846757Z","caller":"traceutil/trace.go:171","msg":"trace[902762086] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2219; }","duration":"257.113299ms","start":"2026-09-11T17:25:53.589627Z","end":"2026-09-11T17:25:53.846741Z","steps":["trace[902762086] 'agreement among raft nodes before linearized reading' (duration: 256.998247ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:25:53.846831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.476857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-11T17:25:53.846921Z","caller":"traceutil/trace.go:171","msg":"trace[449989487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2219; }","duration":"624.601488ms","start":"2026-09-11T17:25:53.222285Z","end":"2026-09-11T17:25:53.846886Z","steps":["trace[449989487] 'agreement among raft nodes before linearized reading' (duration: 624.367525ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:25:53.847026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:25:53.222266Z","time spent":"624.723139ms","remote":"127.0.0.1:37674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-11T17:25:53.846509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:25:53.330123Z","time spent":"515.926395ms","remote":"127.0.0.1:37674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-11T17:25:53.847312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.986064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-11T17:25:53.847425Z","caller":"traceutil/trace.go:171","msg":"trace[1622839462] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2219; }","duration":"625.184917ms","start":"2026-09-11T17:25:53.22222Z","end":"2026-09-11T17:25:53.847405Z","steps":["trace[1622839462] 'agreement among raft nodes before linearized reading' (duration: 624.410005ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:25:53.847472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:25:53.222179Z","time spent":"625.279209ms","remote":"127.0.0.1:37674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-11T17:25:53.973303Z","caller":"traceutil/trace.go:171","msg":"trace[5008042] transaction","detail":"{read_only:false; response_revision:2220; number_of_response:1; }","duration":"122.404272ms","start":"2026-09-11T17:25:53.850787Z","end":"2026-09-11T17:25:53.973191Z","steps":["trace[5008042] 'process raft request' (duration: 107.496976ms)","trace[5008042] 'compare' (duration: 14.56505ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:25:53.97486Z","caller":"traceutil/trace.go:171","msg":"trace[1997804430] transaction","detail":"{read_only:false; response_revision:2221; number_of_response:1; }","duration":"124.026147ms","start":"2026-09-11T17:25:53.850808Z","end":"2026-09-11T17:25:53.974834Z","steps":["trace[1997804430] 'process raft request' (duration: 123.869265ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:25:53.97513Z","caller":"traceutil/trace.go:171","msg":"trace[729280230] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"123.995286ms","start":"2026-09-11T17:25:53.85105Z","end":"2026-09-11T17:25:53.975045Z","steps":["trace[729280230] 'process raft request' (duration: 123.739412ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:26:26.171495Z","caller":"traceutil/trace.go:171","msg":"trace[685103975] linearizableReadLoop","detail":"{readStateIndex:2540; appliedIndex:2539; }","duration":"132.561955ms","start":"2026-09-11T17:26:26.038911Z","end":"2026-09-11T17:26:26.171473Z","steps":["trace[685103975] 'read index received' (duration: 132.302982ms)","trace[685103975] 'applied index is now lower than readState.Index' (duration: 258.193µs)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:26:26.172249Z","caller":"traceutil/trace.go:171","msg":"trace[245050850] transaction","detail":"{read_only:false; response_revision:2444; number_of_response:1; }","duration":"142.579778ms","start":"2026-09-11T17:26:26.029636Z","end":"2026-09-11T17:26:26.172216Z","steps":["trace[245050850] 'process raft request' (duration: 141.702255ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:26:26.172561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.62523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-09-11T17:26:26.172621Z","caller":"traceutil/trace.go:171","msg":"trace[241556952] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2444; }","duration":"133.725622ms","start":"2026-09-11T17:26:26.038881Z","end":"2026-09-11T17:26:26.172606Z","steps":["trace[241556952] 'agreement among raft nodes before linearized reading' (duration: 133.56791ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:26:37.295251Z","caller":"traceutil/trace.go:171","msg":"trace[1399721648] linearizableReadLoop","detail":"{readStateIndex:2658; appliedIndex:2657; }","duration":"105.786113ms","start":"2026-09-11T17:26:37.189438Z","end":"2026-09-11T17:26:37.295224Z","steps":["trace[1399721648] 'read index received' (duration: 105.58369ms)","trace[1399721648] 'applied index is now lower than readState.Index' (duration: 200.933µs)"],"step_count":2} {"level":"warn","ts":"2026-09-11T17:26:37.295415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.941025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T17:26:37.295355Z","caller":"traceutil/trace.go:171","msg":"trace[1436748157] transaction","detail":"{read_only:false; response_revision:2560; number_of_response:1; }","duration":"310.639827ms","start":"2026-09-11T17:26:36.984667Z","end":"2026-09-11T17:26:37.295307Z","steps":["trace[1436748157] 'process raft request' (duration: 310.368223ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:26:37.295464Z","caller":"traceutil/trace.go:171","msg":"trace[17888363] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:2560; }","duration":"106.052526ms","start":"2026-09-11T17:26:37.189396Z","end":"2026-09-11T17:26:37.295449Z","steps":["trace[17888363] 'agreement among raft nodes before linearized reading' (duration: 105.941464ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:26:37.295549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:26:36.984642Z","time spent":"310.837749ms","remote":"127.0.0.1:37674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-11T17:26:37.297487Z","caller":"traceutil/trace.go:171","msg":"trace[1279967246] transaction","detail":"{read_only:false; response_revision:2561; number_of_response:1; }","duration":"106.869438ms","start":"2026-09-11T17:26:37.190607Z","end":"2026-09-11T17:26:37.297477Z","steps":["trace[1279967246] 'process raft request' (duration: 106.800288ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:27:07.667671Z","caller":"traceutil/trace.go:171","msg":"trace[750720599] linearizableReadLoop","detail":"{readStateIndex:2832; appliedIndex:2831; }","duration":"218.445034ms","start":"2026-09-11T17:27:07.449202Z","end":"2026-09-11T17:27:07.667647Z","steps":["trace[750720599] 'read index received' (duration: 218.258751ms)","trace[750720599] 'applied index is now lower than readState.Index' (duration: 185.403µs)"],"step_count":2} {"level":"warn","ts":"2026-09-11T17:27:07.667967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.721887ms","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-09-11T17:27:07.668095Z","caller":"traceutil/trace.go:171","msg":"trace[1401416026] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2727; }","duration":"218.928939ms","start":"2026-09-11T17:27:07.449152Z","end":"2026-09-11T17:27:07.668081Z","steps":["trace[1401416026] 'agreement among raft nodes before linearized reading' (duration: 218.637385ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:27:07.668332Z","caller":"traceutil/trace.go:171","msg":"trace[2014804638] transaction","detail":"{read_only:false; response_revision:2727; number_of_response:1; }","duration":"268.64155ms","start":"2026-09-11T17:27:07.399655Z","end":"2026-09-11T17:27:07.668296Z","steps":["trace[2014804638] 'process raft request' (duration: 267.84596ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:27:13.038474Z","caller":"traceutil/trace.go:171","msg":"trace[608738888] transaction","detail":"{read_only:false; response_revision:2757; number_of_response:1; }","duration":"135.027242ms","start":"2026-09-11T17:27:12.903422Z","end":"2026-09-11T17:27:13.038449Z","steps":["trace[608738888] 'process raft request' (duration: 134.8765ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:27:13.335208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.201087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T17:27:13.33531Z","caller":"traceutil/trace.go:171","msg":"trace[590134235] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2757; }","duration":"227.325088ms","start":"2026-09-11T17:27:13.107955Z","end":"2026-09-11T17:27:13.33528Z","steps":["trace[590134235] 'range keys from in-memory index tree' (duration: 227.148256ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:31:32.647114Z","caller":"traceutil/trace.go:171","msg":"trace[825194819] linearizableReadLoop","detail":"{readStateIndex:4888; appliedIndex:4887; }","duration":"103.503812ms","start":"2026-09-11T17:31:32.543592Z","end":"2026-09-11T17:31:32.647096Z","steps":["trace[825194819] 'read index received' (duration: 83.234885ms)","trace[825194819] 'applied index is now lower than readState.Index' (duration: 20.268297ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:31:32.6472Z","caller":"traceutil/trace.go:171","msg":"trace[1207555426] transaction","detail":"{read_only:false; response_revision:4705; number_of_response:1; }","duration":"104.284677ms","start":"2026-09-11T17:31:32.542908Z","end":"2026-09-11T17:31:32.647193Z","steps":["trace[1207555426] 'process raft request' (duration: 83.903308ms)","trace[1207555426] 'compare' (duration: 20.200636ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T17:31:32.647334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.725896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"} {"level":"info","ts":"2026-09-11T17:31:32.647367Z","caller":"traceutil/trace.go:171","msg":"trace[1496857547] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4705; }","duration":"103.782557ms","start":"2026-09-11T17:31:32.543576Z","end":"2026-09-11T17:31:32.647359Z","steps":["trace[1496857547] 'agreement among raft nodes before linearized reading' (duration: 103.631134ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:31:32.66338Z","caller":"traceutil/trace.go:171","msg":"trace[1814972311] transaction","detail":"{read_only:false; response_revision:4706; number_of_response:1; }","duration":"116.933515ms","start":"2026-09-11T17:31:32.546428Z","end":"2026-09-11T17:31:32.663361Z","steps":["trace[1814972311] 'process raft request' (duration: 116.702921ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:31:32.663599Z","caller":"traceutil/trace.go:171","msg":"trace[529021406] transaction","detail":"{read_only:false; response_revision:4707; number_of_response:1; }","duration":"116.405967ms","start":"2026-09-11T17:31:32.547184Z","end":"2026-09-11T17:31:32.66359Z","steps":["trace[529021406] 'process raft request' (duration: 116.106191ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:32.663687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.39106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-09-11T17:31:32.663756Z","caller":"traceutil/trace.go:171","msg":"trace[321215640] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4707; }","duration":"119.487063ms","start":"2026-09-11T17:31:32.544254Z","end":"2026-09-11T17:31:32.663741Z","steps":["trace[321215640] 'agreement among raft nodes before linearized reading' (duration: 119.246269ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:32.664082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.525082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-10c534e2-f8e6-48be-883f-c5dd1c75da72\" ","response":"range_response_count:1 size:3760"} {"level":"info","ts":"2026-09-11T17:31:32.664185Z","caller":"traceutil/trace.go:171","msg":"trace[1595212199] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-10c534e2-f8e6-48be-883f-c5dd1c75da72; range_end:; response_count:1; response_revision:4707; }","duration":"119.664774ms","start":"2026-09-11T17:31:32.544501Z","end":"2026-09-11T17:31:32.664165Z","steps":["trace[1595212199] 'agreement among raft nodes before linearized reading' (duration: 119.42316ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:31:37.003066Z","caller":"traceutil/trace.go:171","msg":"trace[1586764496] transaction","detail":"{read_only:false; response_revision:4789; number_of_response:1; }","duration":"104.611184ms","start":"2026-09-11T17:31:36.898427Z","end":"2026-09-11T17:31:37.003038Z","steps":["trace[1586764496] 'process raft request' (duration: 104.346829ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:31:37.205338Z","caller":"traceutil/trace.go:171","msg":"trace[880288292] linearizableReadLoop","detail":"{readStateIndex:4976; appliedIndex:4975; }","duration":"119.943416ms","start":"2026-09-11T17:31:37.085284Z","end":"2026-09-11T17:31:37.205228Z","steps":["trace[880288292] 'read index received' (duration: 119.736623ms)","trace[880288292] 'applied index is now lower than readState.Index' (duration: 205.873µs)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:31:37.205357Z","caller":"traceutil/trace.go:171","msg":"trace[417069831] transaction","detail":"{read_only:false; response_revision:4790; number_of_response:1; }","duration":"186.024244ms","start":"2026-09-11T17:31:37.019304Z","end":"2026-09-11T17:31:37.205328Z","steps":["trace[417069831] 'process raft request' (duration: 185.742829ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:37.205589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.276253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-11T17:31:37.205662Z","caller":"traceutil/trace.go:171","msg":"trace[2143994395] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4790; }","duration":"120.363615ms","start":"2026-09-11T17:31:37.085278Z","end":"2026-09-11T17:31:37.205642Z","steps":["trace[2143994395] 'agreement among raft nodes before linearized reading' (duration: 120.13054ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:40.09604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.272151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-11T17:31:40.096108Z","caller":"traceutil/trace.go:171","msg":"trace[1320042713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4850; }","duration":"186.366682ms","start":"2026-09-11T17:31:39.909727Z","end":"2026-09-11T17:31:40.096093Z","steps":["trace[1320042713] 'range keys from in-memory index tree' (duration: 186.151708ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:40.096187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.409777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-11T17:31:40.096241Z","caller":"traceutil/trace.go:171","msg":"trace[523228019] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4850; }","duration":"208.509139ms","start":"2026-09-11T17:31:39.887718Z","end":"2026-09-11T17:31:40.096227Z","steps":["trace[523228019] 'range keys from in-memory index tree' (duration: 208.088272ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:40.096304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.307171ms","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-09-11T17:31:40.096381Z","caller":"traceutil/trace.go:171","msg":"trace[1953569424] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4850; }","duration":"220.412083ms","start":"2026-09-11T17:31:39.87595Z","end":"2026-09-11T17:31:40.096362Z","steps":["trace[1953569424] 'range keys from in-memory index tree' (duration: 220.114947ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:40.096479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.936362ms","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-09-11T17:31:40.096507Z","caller":"traceutil/trace.go:171","msg":"trace[1422885422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4850; }","duration":"186.988693ms","start":"2026-09-11T17:31:39.909511Z","end":"2026-09-11T17:31:40.0965Z","steps":["trace[1422885422] 'range keys from in-memory index tree' (duration: 186.770389ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:31:40.34842Z","caller":"traceutil/trace.go:171","msg":"trace[1272691687] linearizableReadLoop","detail":"{readStateIndex:5044; appliedIndex:5040; }","duration":"244.233207ms","start":"2026-09-11T17:31:40.104166Z","end":"2026-09-11T17:31:40.348399Z","steps":["trace[1272691687] 'read index received' (duration: 79.650378ms)","trace[1272691687] 'applied index is now lower than readState.Index' (duration: 164.579319ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:31:40.348457Z","caller":"traceutil/trace.go:171","msg":"trace[1224586755] transaction","detail":"{read_only:false; response_revision:4853; number_of_response:1; }","duration":"247.834102ms","start":"2026-09-11T17:31:40.100597Z","end":"2026-09-11T17:31:40.348432Z","steps":["trace[1224586755] 'process raft request' (duration: 247.705059ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:31:40.348493Z","caller":"traceutil/trace.go:171","msg":"trace[116204041] transaction","detail":"{read_only:false; response_revision:4854; number_of_response:1; }","duration":"247.822841ms","start":"2026-09-11T17:31:40.100645Z","end":"2026-09-11T17:31:40.348468Z","steps":["trace[116204041] 'process raft request' (duration: 247.691189ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:31:40.348597Z","caller":"traceutil/trace.go:171","msg":"trace[1402327412] transaction","detail":"{read_only:false; response_revision:4852; number_of_response:1; }","duration":"248.411762ms","start":"2026-09-11T17:31:40.100167Z","end":"2026-09-11T17:31:40.348579Z","steps":["trace[1402327412] 'process raft request' (duration: 247.984075ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:40.348599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.41791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T17:31:40.348659Z","caller":"traceutil/trace.go:171","msg":"trace[156500193] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4854; }","duration":"244.535002ms","start":"2026-09-11T17:31:40.104108Z","end":"2026-09-11T17:31:40.348643Z","steps":["trace[156500193] 'agreement among raft nodes before linearized reading' (duration: 244.42776ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:40.348669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.198171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T17:31:40.348713Z","caller":"traceutil/trace.go:171","msg":"trace[776014232] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:4854; }","duration":"160.267542ms","start":"2026-09-11T17:31:40.188429Z","end":"2026-09-11T17:31:40.348697Z","steps":["trace[776014232] 'agreement among raft nodes before linearized reading' (duration: 160.208241ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:40.348601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.562675ms","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-09-11T17:31:40.348756Z","caller":"traceutil/trace.go:171","msg":"trace[568780631] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:4854; }","duration":"214.763249ms","start":"2026-09-11T17:31:40.13398Z","end":"2026-09-11T17:31:40.348743Z","steps":["trace[568780631] 'agreement among raft nodes before linearized reading' (duration: 214.562416ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:46.679968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.298974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18d4548a84831bcd\" ","response":"range_response_count:1 size:751"} {"level":"info","ts":"2026-09-11T17:31:46.680059Z","caller":"traceutil/trace.go:171","msg":"trace[1420719606] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18d4548a84831bcd; range_end:; response_count:1; response_revision:4955; }","duration":"720.417846ms","start":"2026-09-11T17:31:45.959616Z","end":"2026-09-11T17:31:46.680034Z","steps":["trace[1420719606] 'range keys from in-memory index tree' (duration: 720.230263ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:46.680121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:31:45.959602Z","time spent":"720.508388ms","remote":"127.0.0.1:37488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":773,"request content":"key:\"/registry/events/openstack/rabbitmq-keystone.18d4548a84831bcd\" "} {"level":"warn","ts":"2026-09-11T17:31:46.680405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.54606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-09-11T17:31:46.680442Z","caller":"traceutil/trace.go:171","msg":"trace[1887083987] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4955; }","duration":"610.61651ms","start":"2026-09-11T17:31:46.069813Z","end":"2026-09-11T17:31:46.68043Z","steps":["trace[1887083987] 'range keys from in-memory index tree' (duration: 610.403167ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:46.680478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:31:46.069795Z","time spent":"610.674112ms","remote":"127.0.0.1:37600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":919,"request content":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" "} {"level":"warn","ts":"2026-09-11T17:31:46.68054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.788902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-09-11T17:31:46.680594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.058606ms","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-09-11T17:31:46.680606Z","caller":"traceutil/trace.go:171","msg":"trace[1025714448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4955; }","duration":"306.881683ms","start":"2026-09-11T17:31:46.373708Z","end":"2026-09-11T17:31:46.680589Z","steps":["trace[1025714448] 'range keys from in-memory index tree' (duration: 306.659199ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:46.680643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:31:46.373699Z","time spent":"306.937364ms","remote":"127.0.0.1:37674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-11T17:31:46.68064Z","caller":"traceutil/trace.go:171","msg":"trace[266619367] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4955; }","duration":"307.121369ms","start":"2026-09-11T17:31:46.373502Z","end":"2026-09-11T17:31:46.680623Z","steps":["trace[266619367] 'range keys from in-memory index tree' (duration: 306.886483ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:46.680655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.163799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-09-11T17:31:46.680675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:31:46.37349Z","time spent":"307.17724ms","remote":"127.0.0.1:37674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-11T17:31:46.680701Z","caller":"traceutil/trace.go:171","msg":"trace[940853310] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4955; }","duration":"307.24314ms","start":"2026-09-11T17:31:46.373445Z","end":"2026-09-11T17:31:46.680688Z","steps":["trace[940853310] 'range keys from in-memory index tree' (duration: 306.854223ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:46.6807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.277694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-11T17:31:46.68073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:31:46.373426Z","time spent":"307.296591ms","remote":"127.0.0.1:37674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-11T17:31:46.680739Z","caller":"traceutil/trace.go:171","msg":"trace[962001793] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4955; }","duration":"574.353596ms","start":"2026-09-11T17:31:46.106374Z","end":"2026-09-11T17:31:46.680728Z","steps":["trace[962001793] 'range keys from in-memory index tree' (duration: 574.230683ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:46.680772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:31:46.106358Z","time spent":"574.406136ms","remote":"127.0.0.1:37394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-11T17:31:46.680379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.665467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T17:31:46.680864Z","caller":"traceutil/trace.go:171","msg":"trace[45589701] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:4955; }","duration":"632.208636ms","start":"2026-09-11T17:31:46.048644Z","end":"2026-09-11T17:31:46.680852Z","steps":["trace[45589701] 'count revisions from in-memory index tree' (duration: 631.559644ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:46.680889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:31:46.048625Z","time spent":"632.254226ms","remote":"127.0.0.1:57770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-09-11T17:31:46.680944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.00029ms","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-09-11T17:31:46.681017Z","caller":"traceutil/trace.go:171","msg":"trace[360851920] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4955; }","duration":"469.119391ms","start":"2026-09-11T17:31:46.211878Z","end":"2026-09-11T17:31:46.680997Z","steps":["trace[360851920] 'range keys from in-memory index tree' (duration: 468.875408ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:46.681059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:31:46.211858Z","time spent":"469.190943ms","remote":"127.0.0.1:37674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-11T17:31:46.682204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.496446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-09-11T17:31:46.682269Z","caller":"traceutil/trace.go:171","msg":"trace[753819397] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4955; }","duration":"712.582218ms","start":"2026-09-11T17:31:45.969669Z","end":"2026-09-11T17:31:46.682251Z","steps":["trace[753819397] 'range keys from in-memory index tree' (duration: 710.407788ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:46.682309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:31:45.969656Z","time spent":"712.642208ms","remote":"127.0.0.1:37506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2207440,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-09-11T17:31:47.17307Z","caller":"traceutil/trace.go:171","msg":"trace[2111783186] transaction","detail":"{read_only:false; response_revision:4974; number_of_response:1; }","duration":"260.670468ms","start":"2026-09-11T17:31:46.912342Z","end":"2026-09-11T17:31:47.173013Z","steps":["trace[2111783186] 'process raft request' (duration: 223.195531ms)","trace[2111783186] 'compare' (duration: 37.057159ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:31:47.173339Z","caller":"traceutil/trace.go:171","msg":"trace[1587246635] transaction","detail":"{read_only:false; response_revision:4975; number_of_response:1; }","duration":"260.77056ms","start":"2026-09-11T17:31:46.91252Z","end":"2026-09-11T17:31:47.173291Z","steps":["trace[1587246635] 'process raft request' (duration: 260.394272ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:31:47.173714Z","caller":"traceutil/trace.go:171","msg":"trace[1277547072] transaction","detail":"{read_only:false; response_revision:4976; number_of_response:1; }","duration":"261.058834ms","start":"2026-09-11T17:31:46.912631Z","end":"2026-09-11T17:31:47.17369Z","steps":["trace[1277547072] 'process raft request' (duration: 260.764319ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:31:47.173856Z","caller":"traceutil/trace.go:171","msg":"trace[1638039456] transaction","detail":"{read_only:false; response_revision:4977; number_of_response:1; }","duration":"215.89282ms","start":"2026-09-11T17:31:46.957947Z","end":"2026-09-11T17:31:47.173839Z","steps":["trace[1638039456] 'process raft request' (duration: 215.665996ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:31:47.17389Z","caller":"traceutil/trace.go:171","msg":"trace[1235036316] linearizableReadLoop","detail":"{readStateIndex:5168; appliedIndex:5164; }","duration":"259.799422ms","start":"2026-09-11T17:31:46.914073Z","end":"2026-09-11T17:31:47.173872Z","steps":["trace[1235036316] 'read index received' (duration: 49.304418ms)","trace[1235036316] 'applied index is now lower than readState.Index' (duration: 210.493194ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T17:31:47.17406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.964244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T17:31:47.174157Z","caller":"traceutil/trace.go:171","msg":"trace[868917074] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:4977; }","duration":"260.078526ms","start":"2026-09-11T17:31:46.914057Z","end":"2026-09-11T17:31:47.174135Z","steps":["trace[868917074] 'agreement among raft nodes before linearized reading' (duration: 259.932454ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:31:47.360956Z","caller":"traceutil/trace.go:171","msg":"trace[90522365] transaction","detail":"{read_only:false; response_revision:4978; number_of_response:1; }","duration":"152.36189ms","start":"2026-09-11T17:31:47.208577Z","end":"2026-09-11T17:31:47.360938Z","steps":["trace[90522365] 'process raft request' (duration: 89.242177ms)","trace[90522365] 'compare' (duration: 62.764496ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:31:47.544234Z","caller":"traceutil/trace.go:171","msg":"trace[434715733] transaction","detail":"{read_only:false; response_revision:4979; number_of_response:1; }","duration":"179.592934ms","start":"2026-09-11T17:31:47.364619Z","end":"2026-09-11T17:31:47.544212Z","steps":["trace[434715733] 'process raft request' (duration: 170.077585ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:31:49.931832Z","caller":"traceutil/trace.go:171","msg":"trace[245138524] transaction","detail":"{read_only:false; response_revision:5002; number_of_response:1; }","duration":"144.073326ms","start":"2026-09-11T17:31:49.787733Z","end":"2026-09-11T17:31:49.931806Z","steps":["trace[245138524] 'process raft request' (duration: 143.787592ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:31:59.814165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.411917ms","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-09-11T17:31:59.814865Z","caller":"traceutil/trace.go:171","msg":"trace[1983930025] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5124; }","duration":"202.14447ms","start":"2026-09-11T17:31:59.612696Z","end":"2026-09-11T17:31:59.81484Z","steps":["trace[1983930025] 'range keys from in-memory index tree' (duration: 201.203424ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:32:00.031088Z","caller":"traceutil/trace.go:171","msg":"trace[678387028] transaction","detail":"{read_only:false; response_revision:5126; number_of_response:1; }","duration":"138.070205ms","start":"2026-09-11T17:31:59.892985Z","end":"2026-09-11T17:32:00.031055Z","steps":["trace[678387028] 'process raft request' (duration: 137.835691ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:32:00.197747Z","caller":"traceutil/trace.go:171","msg":"trace[265738107] transaction","detail":"{read_only:false; response_revision:5129; number_of_response:1; }","duration":"158.924139ms","start":"2026-09-11T17:32:00.038789Z","end":"2026-09-11T17:32:00.197713Z","steps":["trace[265738107] 'process raft request' (duration: 106.707903ms)","trace[265738107] 'compare' (duration: 51.697667ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:32:00.197782Z","caller":"traceutil/trace.go:171","msg":"trace[1786105781] transaction","detail":"{read_only:false; response_revision:5130; number_of_response:1; }","duration":"158.720615ms","start":"2026-09-11T17:32:00.039049Z","end":"2026-09-11T17:32:00.19777Z","steps":["trace[1786105781] 'process raft request' (duration: 158.589952ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:32:00.197807Z","caller":"traceutil/trace.go:171","msg":"trace[391775166] transaction","detail":"{read_only:false; response_revision:5131; number_of_response:1; }","duration":"142.392849ms","start":"2026-09-11T17:32:00.055401Z","end":"2026-09-11T17:32:00.197794Z","steps":["trace[391775166] 'process raft request' (duration: 142.296757ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:32:00.197756Z","caller":"traceutil/trace.go:171","msg":"trace[600249347] linearizableReadLoop","detail":"{readStateIndex:5330; appliedIndex:5327; }","duration":"135.983435ms","start":"2026-09-11T17:32:00.061753Z","end":"2026-09-11T17:32:00.197737Z","steps":["trace[600249347] 'read index received' (duration: 50.006357ms)","trace[600249347] 'applied index is now lower than readState.Index' (duration: 85.976228ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T17:32:00.197867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.092267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T17:32:00.198101Z","caller":"traceutil/trace.go:171","msg":"trace[858100264] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:5131; }","duration":"136.365522ms","start":"2026-09-11T17:32:00.061723Z","end":"2026-09-11T17:32:00.198089Z","steps":["trace[858100264] 'agreement among raft nodes before linearized reading' (duration: 136.086207ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:32:34.319987Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2869} {"level":"info","ts":"2026-09-11T17:32:34.398248Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2869,"took":"77.062842ms","hash":2715846728,"current-db-size-bytes":52862976,"current-db-size":"53 MB","current-db-size-in-use-bytes":28209152,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-11T17:32:34.398302Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2715846728,"revision":2869,"compact-revision":-1} {"level":"info","ts":"2026-09-11T17:34:56.124259Z","caller":"traceutil/trace.go:171","msg":"trace[143556768] transaction","detail":"{read_only:false; response_revision:6347; number_of_response:1; }","duration":"620.812961ms","start":"2026-09-11T17:34:55.503419Z","end":"2026-09-11T17:34:56.124231Z","steps":["trace[143556768] 'process raft request' (duration: 620.660388ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:34:56.124411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:34:55.503399Z","time spent":"620.932233ms","remote":"127.0.0.1:37674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-11T17:34:56.132228Z","caller":"traceutil/trace.go:171","msg":"trace[1119792528] linearizableReadLoop","detail":"{readStateIndex:6587; appliedIndex:6584; }","duration":"300.848629ms","start":"2026-09-11T17:34:55.831358Z","end":"2026-09-11T17:34:56.132207Z","steps":["trace[1119792528] 'read index received' (duration: 292.581627ms)","trace[1119792528] 'applied index is now lower than readState.Index' (duration: 8.265832ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:34:56.132272Z","caller":"traceutil/trace.go:171","msg":"trace[974127118] transaction","detail":"{read_only:false; response_revision:6348; number_of_response:1; }","duration":"534.486211ms","start":"2026-09-11T17:34:55.597761Z","end":"2026-09-11T17:34:56.132247Z","steps":["trace[974127118] 'process raft request' (duration: 534.316418ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:34:56.132707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:34:55.597739Z","time spent":"534.885316ms","remote":"127.0.0.1:37674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-11T17:34:56.133153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.327617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-11T17:34:56.133186Z","caller":"traceutil/trace.go:171","msg":"trace[1800182490] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6349; }","duration":"245.403089ms","start":"2026-09-11T17:34:55.887773Z","end":"2026-09-11T17:34:56.133176Z","steps":["trace[1800182490] 'agreement among raft nodes before linearized reading' (duration: 245.306336ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:34:56.132308Z","caller":"traceutil/trace.go:171","msg":"trace[74819737] transaction","detail":"{read_only:false; response_revision:6349; number_of_response:1; }","duration":"461.288018ms","start":"2026-09-11T17:34:55.670997Z","end":"2026-09-11T17:34:56.132285Z","steps":["trace[74819737] 'process raft request' (duration: 461.182867ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:34:56.133756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:34:55.670978Z","time spent":"462.719181ms","remote":"127.0.0.1:37674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-11T17:34:56.132413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.037252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-11T17:34:56.133965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.187883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-11T17:34:56.134038Z","caller":"traceutil/trace.go:171","msg":"trace[1769375014] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6349; }","duration":"114.286275ms","start":"2026-09-11T17:34:56.019738Z","end":"2026-09-11T17:34:56.134024Z","steps":["trace[1769375014] 'agreement among raft nodes before linearized reading' (duration: 114.132222ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:34:56.133993Z","caller":"traceutil/trace.go:171","msg":"trace[1055146278] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6349; }","duration":"302.664508ms","start":"2026-09-11T17:34:55.831312Z","end":"2026-09-11T17:34:56.133976Z","steps":["trace[1055146278] 'agreement among raft nodes before linearized reading' (duration: 300.994942ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:34:56.134294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.501996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-11T17:34:56.13431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T17:34:55.831292Z","time spent":"302.982672ms","remote":"127.0.0.1:37394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-11T17:34:56.134334Z","caller":"traceutil/trace.go:171","msg":"trace[1070035156] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6349; }","duration":"112.581428ms","start":"2026-09-11T17:34:56.021743Z","end":"2026-09-11T17:34:56.134325Z","steps":["trace[1070035156] 'agreement among raft nodes before linearized reading' (duration: 112.434416ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T17:34:56.13469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.843865ms","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-09-11T17:34:56.134743Z","caller":"traceutil/trace.go:171","msg":"trace[1006160372] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6349; }","duration":"150.922667ms","start":"2026-09-11T17:34:55.98381Z","end":"2026-09-11T17:34:56.134733Z","steps":["trace[1006160372] 'agreement among raft nodes before linearized reading' (duration: 150.818416ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:35:52.542477Z","caller":"traceutil/trace.go:171","msg":"trace[103993061] transaction","detail":"{read_only:false; response_revision:6853; number_of_response:1; }","duration":"128.121962ms","start":"2026-09-11T17:35:52.414335Z","end":"2026-09-11T17:35:52.542457Z","steps":["trace[103993061] 'process raft request' (duration: 107.031752ms)","trace[103993061] 'compare' (duration: 20.912504ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T17:35:52.542604Z","caller":"traceutil/trace.go:171","msg":"trace[975794641] transaction","detail":"{read_only:false; response_revision:6854; number_of_response:1; }","duration":"105.645376ms","start":"2026-09-11T17:35:52.43695Z","end":"2026-09-11T17:35:52.542595Z","steps":["trace[975794641] 'process raft request' (duration: 105.422478ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T17:37:34.325593Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5453} {"level":"info","ts":"2026-09-11T17:37:34.404686Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5453,"took":"77.666732ms","hash":3004480528,"current-db-size-bytes":52862976,"current-db-size":"53 MB","current-db-size-in-use-bytes":18481152,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-09-11T17:37:34.404743Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3004480528,"revision":5453,"compact-revision":2869}