{"level":"warn","ts":"2026-09-08T22:50:20.858964Z","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-08T22:50:20.859144Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.119: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.119:2380","--initial-cluster=instance=https://162.253.55.119:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.119:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.119: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-08T22:50:20.859286Z","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-08T22:50:20.85932Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.119:2380"]} {"level":"info","ts":"2026-09-08T22:50:20.859366Z","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-08T22:50:20.860973Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.119:2379"]} {"level":"info","ts":"2026-09-08T22:50:20.861158Z","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://162.253.55.119:2380"],"listen-peer-urls":["https://162.253.55.119:2380"],"advertise-client-urls":["https://162.253.55.119:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.119:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.119: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-08T22:50:20.865266Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.622406ms"} {"level":"info","ts":"2026-09-08T22:50:20.87286Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2f0e00eb3c3ee1b","cluster-id":"8e467f099f65c603"} {"level":"info","ts":"2026-09-08T22:50:20.873036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b switched to configuration voters=()"} {"level":"info","ts":"2026-09-08T22:50:20.873094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became follower at term 0"} {"level":"info","ts":"2026-09-08T22:50:20.873113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2f0e00eb3c3ee1b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-08T22:50:20.873147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became follower at term 1"} {"level":"info","ts":"2026-09-08T22:50:20.873216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b switched to configuration voters=(211915536236539419)"} {"level":"warn","ts":"2026-09-08T22:50:20.879448Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-08T22:50:20.881487Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-08T22:50:20.88322Z","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-08T22:50:20.886014Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2f0e00eb3c3ee1b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-08T22:50:20.886262Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2f0e00eb3c3ee1b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-08T22:50:20.886524Z","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-08T22:50:20.886663Z","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-08T22:50:20.88668Z","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-08T22:50:20.888656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b switched to configuration voters=(211915536236539419)"} {"level":"info","ts":"2026-09-08T22:50:20.888995Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8e467f099f65c603","local-member-id":"2f0e00eb3c3ee1b","added-peer-id":"2f0e00eb3c3ee1b","added-peer-peer-urls":["https://162.253.55.119:2380"]} {"level":"info","ts":"2026-09-08T22:50:20.89363Z","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-08T22:50:20.893769Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.119:2380"} {"level":"info","ts":"2026-09-08T22:50:20.893892Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.119:2380"} {"level":"info","ts":"2026-09-08T22:50:20.894267Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2f0e00eb3c3ee1b","initial-advertise-peer-urls":["https://162.253.55.119:2380"],"listen-peer-urls":["https://162.253.55.119:2380"],"advertise-client-urls":["https://162.253.55.119:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.119:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-08T22:50:20.89432Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-08T22:50:21.574546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b is starting a new election at term 1"} {"level":"info","ts":"2026-09-08T22:50:21.57463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became pre-candidate at term 1"} {"level":"info","ts":"2026-09-08T22:50:21.574673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b received MsgPreVoteResp from 2f0e00eb3c3ee1b at term 1"} {"level":"info","ts":"2026-09-08T22:50:21.574702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became candidate at term 2"} {"level":"info","ts":"2026-09-08T22:50:21.574714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b received MsgVoteResp from 2f0e00eb3c3ee1b at term 2"} {"level":"info","ts":"2026-09-08T22:50:21.574734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2f0e00eb3c3ee1b became leader at term 2"} {"level":"info","ts":"2026-09-08T22:50:21.57476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2f0e00eb3c3ee1b elected leader 2f0e00eb3c3ee1b at term 2"} {"level":"info","ts":"2026-09-08T22:50:21.57603Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-08T22:50:21.576988Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-08T22:50:21.576977Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2f0e00eb3c3ee1b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.119:2379]}","request-path":"/0/members/2f0e00eb3c3ee1b/attributes","cluster-id":"8e467f099f65c603","publish-timeout":"7s"} {"level":"info","ts":"2026-09-08T22:50:21.577049Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-08T22:50:21.577419Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-08T22:50:21.577475Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-08T22:50:21.577516Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8e467f099f65c603","local-member-id":"2f0e00eb3c3ee1b","cluster-version":"3.5"} {"level":"info","ts":"2026-09-08T22:50:21.577699Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-08T22:50:21.577754Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-08T22:50:21.579818Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.119:2379"} {"level":"info","ts":"2026-09-08T22:50:21.580163Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-08T22:50:37.426802Z","caller":"traceutil/trace.go:171","msg":"trace[94318085] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"229.825327ms","start":"2026-09-08T22:50:37.196951Z","end":"2026-09-08T22:50:37.426776Z","steps":["trace[94318085] 'process raft request' (duration: 229.647703ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:50:37.654955Z","caller":"traceutil/trace.go:171","msg":"trace[731237070] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"369.829058ms","start":"2026-09-08T22:50:37.285087Z","end":"2026-09-08T22:50:37.654916Z","steps":["trace[731237070] 'process raft request' (duration: 318.270105ms)","trace[731237070] 'compare' (duration: 51.338548ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T22:50:37.655968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T22:50:37.285044Z","time spent":"370.116694ms","remote":"127.0.0.1:50462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4402,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T22:51:21.885926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.652535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T22:51:21.886075Z","caller":"traceutil/trace.go:171","msg":"trace[2054564993] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:667; }","duration":"136.822528ms","start":"2026-09-08T22:51:21.749228Z","end":"2026-09-08T22:51:21.88605Z","steps":["trace[2054564993] 'range keys from in-memory index tree' (duration: 136.549102ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:51:22.234711Z","caller":"traceutil/trace.go:171","msg":"trace[1501168206] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"122.668858ms","start":"2026-09-08T22:51:22.112006Z","end":"2026-09-08T22:51:22.234675Z","steps":["trace[1501168206] 'process raft request' (duration: 122.424182ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:51:22.760746Z","caller":"traceutil/trace.go:171","msg":"trace[1666367530] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"435.154671ms","start":"2026-09-08T22:51:22.325567Z","end":"2026-09-08T22:51:22.760722Z","steps":["trace[1666367530] 'process raft request' (duration: 434.642561ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:51:22.760892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T22:51:22.325541Z","time spent":"435.279883ms","remote":"127.0.0.1:50390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T22:51:38.887046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.725295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T22:51:38.887267Z","caller":"traceutil/trace.go:171","msg":"trace[1756306374] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:835; }","duration":"231.01272ms","start":"2026-09-08T22:51:38.656228Z","end":"2026-09-08T22:51:38.887241Z","steps":["trace[1756306374] 'count revisions from in-memory index tree' (duration: 230.640582ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:52:06.78739Z","caller":"traceutil/trace.go:171","msg":"trace[335489560] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"191.165837ms","start":"2026-09-08T22:52:06.596193Z","end":"2026-09-08T22:52:06.787358Z","steps":["trace[335489560] 'process raft request' (duration: 191.020784ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:52:19.419537Z","caller":"traceutil/trace.go:171","msg":"trace[82881756] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"118.461748ms","start":"2026-09-08T22:52:19.301018Z","end":"2026-09-08T22:52:19.41948Z","steps":["trace[82881756] 'process raft request' (duration: 43.88599ms)","trace[82881756] 'compare' (duration: 74.387564ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T22:52:55.276706Z","caller":"traceutil/trace.go:171","msg":"trace[862646705] linearizableReadLoop","detail":"{readStateIndex:1994; appliedIndex:1993; }","duration":"184.050244ms","start":"2026-09-08T22:52:55.092631Z","end":"2026-09-08T22:52:55.276681Z","steps":["trace[862646705] 'read index received' (duration: 183.787679ms)","trace[862646705] 'applied index is now lower than readState.Index' (duration: 261.195µs)"],"step_count":2} {"level":"warn","ts":"2026-09-08T22:52:55.276968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.327711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.119\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-08T22:52:55.277007Z","caller":"traceutil/trace.go:171","msg":"trace[226820397] range","detail":"{range_begin:/registry/masterleases/162.253.55.119; range_end:; response_count:1; response_revision:1917; }","duration":"184.437163ms","start":"2026-09-08T22:52:55.09256Z","end":"2026-09-08T22:52:55.276997Z","steps":["trace[226820397] 'agreement among raft nodes before linearized reading' (duration: 184.227169ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:52:55.277044Z","caller":"traceutil/trace.go:171","msg":"trace[971845144] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"210.90982ms","start":"2026-09-08T22:52:55.065924Z","end":"2026-09-08T22:52:55.276833Z","steps":["trace[971845144] 'process raft request' (duration: 210.608303ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:52:55.71739Z","caller":"traceutil/trace.go:171","msg":"trace[1913397645] linearizableReadLoop","detail":"{readStateIndex:1997; appliedIndex:1996; }","duration":"107.916352ms","start":"2026-09-08T22:52:55.609447Z","end":"2026-09-08T22:52:55.717364Z","steps":["trace[1913397645] 'read index received' (duration: 107.786359ms)","trace[1913397645] 'applied index is now lower than readState.Index' (duration: 128.673µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T22:52:55.717545Z","caller":"traceutil/trace.go:171","msg":"trace[696683227] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"116.958586ms","start":"2026-09-08T22:52:55.600517Z","end":"2026-09-08T22:52:55.717476Z","steps":["trace[696683227] 'process raft request' (duration: 116.659709ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:52:55.717653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.177258ms","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-09-08T22:52:55.717701Z","caller":"traceutil/trace.go:171","msg":"trace[1967646004] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1919; }","duration":"108.26721ms","start":"2026-09-08T22:52:55.609423Z","end":"2026-09-08T22:52:55.71769Z","steps":["trace[1967646004] 'agreement among raft nodes before linearized reading' (duration: 108.043545ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:53:11.946033Z","caller":"traceutil/trace.go:171","msg":"trace[329150660] transaction","detail":"{read_only:false; response_revision:2055; number_of_response:1; }","duration":"125.010296ms","start":"2026-09-08T22:53:11.820994Z","end":"2026-09-08T22:53:11.946004Z","steps":["trace[329150660] 'process raft request' (duration: 124.848343ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:53:12.689069Z","caller":"traceutil/trace.go:171","msg":"trace[204090724] linearizableReadLoop","detail":"{readStateIndex:2138; appliedIndex:2137; }","duration":"145.023098ms","start":"2026-09-08T22:53:12.54402Z","end":"2026-09-08T22:53:12.689044Z","steps":["trace[204090724] 'read index received' (duration: 144.816894ms)","trace[204090724] 'applied index is now lower than readState.Index' (duration: 205.284µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T22:53:12.689164Z","caller":"traceutil/trace.go:171","msg":"trace[385349080] transaction","detail":"{read_only:false; response_revision:2057; number_of_response:1; }","duration":"155.75821ms","start":"2026-09-08T22:53:12.53338Z","end":"2026-09-08T22:53:12.689138Z","steps":["trace[385349080] 'process raft request' (duration: 155.499015ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:53:12.689301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.265474ms","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-08T22:53:12.689337Z","caller":"traceutil/trace.go:171","msg":"trace[820479156] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2057; }","duration":"145.346606ms","start":"2026-09-08T22:53:12.543982Z","end":"2026-09-08T22:53:12.689329Z","steps":["trace[820479156] 'agreement among raft nodes before linearized reading' (duration: 145.185472ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:53:12.716703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.682747ms","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-08T22:53:12.716769Z","caller":"traceutil/trace.go:171","msg":"trace[1967335869] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2058; }","duration":"167.780079ms","start":"2026-09-08T22:53:12.548975Z","end":"2026-09-08T22:53:12.716755Z","steps":["trace[1967335869] 'agreement among raft nodes before linearized reading' (duration: 167.570764ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:53:12.716666Z","caller":"traceutil/trace.go:171","msg":"trace[968776018] transaction","detail":"{read_only:false; response_revision:2058; number_of_response:1; }","duration":"116.976234ms","start":"2026-09-08T22:53:12.59964Z","end":"2026-09-08T22:53:12.716616Z","steps":["trace[968776018] 'process raft request' (duration: 116.769849ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:59:42.902583Z","caller":"traceutil/trace.go:171","msg":"trace[69798260] linearizableReadLoop","detail":"{readStateIndex:5188; appliedIndex:5187; }","duration":"120.802339ms","start":"2026-09-08T22:59:42.781757Z","end":"2026-09-08T22:59:42.902559Z","steps":["trace[69798260] 'read index received' (duration: 120.585425ms)","trace[69798260] 'applied index is now lower than readState.Index' (duration: 215.984µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T22:59:42.902817Z","caller":"traceutil/trace.go:171","msg":"trace[31934770] transaction","detail":"{read_only:false; response_revision:4993; number_of_response:1; }","duration":"133.312878ms","start":"2026-09-08T22:59:42.769491Z","end":"2026-09-08T22:59:42.902804Z","steps":["trace[31934770] 'process raft request' (duration: 132.909809ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:59:42.902932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.024793ms","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":"warn","ts":"2026-09-08T22:59:42.902955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.179218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-08T22:59:42.903042Z","caller":"traceutil/trace.go:171","msg":"trace[1579680473] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4993; }","duration":"121.307451ms","start":"2026-09-08T22:59:42.781714Z","end":"2026-09-08T22:59:42.903021Z","steps":["trace[1579680473] 'agreement among raft nodes before linearized reading' (duration: 121.063856ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:59:42.902988Z","caller":"traceutil/trace.go:171","msg":"trace[1707426955] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4993; }","duration":"106.133475ms","start":"2026-09-08T22:59:42.796841Z","end":"2026-09-08T22:59:42.902974Z","steps":["trace[1707426955] 'agreement among raft nodes before linearized reading' (duration: 105.91312ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:59:48.205155Z","caller":"traceutil/trace.go:171","msg":"trace[1528091211] linearizableReadLoop","detail":"{readStateIndex:5357; appliedIndex:5355; }","duration":"137.397145ms","start":"2026-09-08T22:59:48.067732Z","end":"2026-09-08T22:59:48.205129Z","steps":["trace[1528091211] 'read index received' (duration: 15.665256ms)","trace[1528091211] 'applied index is now lower than readState.Index' (duration: 121.730959ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T22:59:48.20522Z","caller":"traceutil/trace.go:171","msg":"trace[278343359] transaction","detail":"{read_only:false; response_revision:5158; number_of_response:1; }","duration":"137.746043ms","start":"2026-09-08T22:59:48.067403Z","end":"2026-09-08T22:59:48.205149Z","steps":["trace[278343359] 'process raft request' (duration: 105.650565ms)","trace[278343359] 'compare' (duration: 31.901473ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T22:59:48.205397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.025087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-09-08T22:59:48.205442Z","caller":"traceutil/trace.go:171","msg":"trace[163016577] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5158; }","duration":"137.132059ms","start":"2026-09-08T22:59:48.068298Z","end":"2026-09-08T22:59:48.20543Z","steps":["trace[163016577] 'agreement among raft nodes before linearized reading' (duration: 136.979516ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:59:48.205438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.693251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:62983"} {"level":"warn","ts":"2026-09-08T22:59:48.205466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.472667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T22:59:48.20549Z","caller":"traceutil/trace.go:171","msg":"trace[1140202917] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:5158; }","duration":"137.764743ms","start":"2026-09-08T22:59:48.067713Z","end":"2026-09-08T22:59:48.205478Z","steps":["trace[1140202917] 'agreement among raft nodes before linearized reading' (duration: 137.501618ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T22:59:48.205554Z","caller":"traceutil/trace.go:171","msg":"trace[1865844184] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:5158; }","duration":"123.60313ms","start":"2026-09-08T22:59:48.081931Z","end":"2026-09-08T22:59:48.205534Z","steps":["trace[1865844184] 'agreement among raft nodes before linearized reading' (duration: 123.442156ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:59:48.205649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.257179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:11455"} {"level":"info","ts":"2026-09-08T22:59:48.20574Z","caller":"traceutil/trace.go:171","msg":"trace[2123834340] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5158; }","duration":"135.378973ms","start":"2026-09-08T22:59:48.070341Z","end":"2026-09-08T22:59:48.20572Z","steps":["trace[2123834340] 'agreement among raft nodes before linearized reading' (duration: 135.115906ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:59:53.229406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.98458ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-08T22:59:53.22979Z","caller":"traceutil/trace.go:171","msg":"trace[420627850] transaction","detail":"{read_only:false; response_revision:5315; number_of_response:1; }","duration":"342.073573ms","start":"2026-09-08T22:59:52.887673Z","end":"2026-09-08T22:59:53.229746Z","steps":["trace[420627850] 'process raft request' (duration: 132.452929ms)","trace[420627850] 'compare' (duration: 208.525981ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T22:59:53.22992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T22:59:52.887647Z","time spent":"342.214165ms","remote":"127.0.0.1:50390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58177,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T22:59:53.230448Z","caller":"traceutil/trace.go:171","msg":"trace[773486468] linearizableReadLoop","detail":"{readStateIndex:5520; appliedIndex:5518; }","duration":"295.018914ms","start":"2026-09-08T22:59:52.935394Z","end":"2026-09-08T22:59:53.230413Z","steps":["trace[773486468] 'read index received' (duration: 84.702095ms)","trace[773486468] 'applied index is now lower than readState.Index' (duration: 210.314289ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T22:59:53.23054Z","caller":"traceutil/trace.go:171","msg":"trace[95430247] transaction","detail":"{read_only:false; response_revision:5316; number_of_response:1; }","duration":"330.051655ms","start":"2026-09-08T22:59:52.900427Z","end":"2026-09-08T22:59:53.230479Z","steps":["trace[95430247] 'process raft request' (duration: 329.269299ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:59:53.230716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.301679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T22:59:53.230804Z","caller":"traceutil/trace.go:171","msg":"trace[57581995] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:5316; }","duration":"295.433632ms","start":"2026-09-08T22:59:52.935349Z","end":"2026-09-08T22:59:53.230782Z","steps":["trace[57581995] 'agreement among raft nodes before linearized reading' (duration: 295.225988ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:59:53.230864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T22:59:52.900413Z","time spent":"330.29757ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4888,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-08T22:59:53.260483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.35761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-09-08T22:59:53.260468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.503723ms","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-08T22:59:53.260594Z","caller":"traceutil/trace.go:171","msg":"trace[1610415003] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5317; }","duration":"301.460202ms","start":"2026-09-08T22:59:52.959109Z","end":"2026-09-08T22:59:53.260569Z","steps":["trace[1610415003] 'agreement among raft nodes before linearized reading' (duration: 301.272328ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:59:53.260454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.076126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-08T22:59:53.260645Z","caller":"traceutil/trace.go:171","msg":"trace[945499823] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5317; }","duration":"303.311332ms","start":"2026-09-08T22:59:52.957322Z","end":"2026-09-08T22:59:53.260634Z","steps":["trace[945499823] 'agreement among raft nodes before linearized reading' (duration: 302.923024ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:59:53.260532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.944899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-69154291-0a9f-4adf-afdd-c70354dbc4b0\" ","response":"range_response_count:1 size:3721"} {"level":"info","ts":"2026-09-08T22:59:53.260799Z","caller":"traceutil/trace.go:171","msg":"trace[201643720] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-69154291-0a9f-4adf-afdd-c70354dbc4b0; range_end:; response_count:1; response_revision:5317; }","duration":"313.298766ms","start":"2026-09-08T22:59:52.947477Z","end":"2026-09-08T22:59:53.260776Z","steps":["trace[201643720] 'agreement among raft nodes before linearized reading' (duration: 312.845126ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:59:53.260904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T22:59:52.947451Z","time spent":"313.433159ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3744,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-69154291-0a9f-4adf-afdd-c70354dbc4b0\" "} {"level":"info","ts":"2026-09-08T22:59:53.2606Z","caller":"traceutil/trace.go:171","msg":"trace[669003633] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5317; }","duration":"301.713218ms","start":"2026-09-08T22:59:52.958868Z","end":"2026-09-08T22:59:53.260581Z","steps":["trace[669003633] 'agreement among raft nodes before linearized reading' (duration: 301.392111ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T22:59:53.261098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T22:59:52.958843Z","time spent":"302.209709ms","remote":"127.0.0.1:50538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-08T22:59:53.260648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T22:59:52.95908Z","time spent":"301.555825ms","remote":"127.0.0.1:50538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-08T22:59:53.260703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T22:59:52.957305Z","time spent":"303.377093ms","remote":"127.0.0.1:50538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-08T23:00:07.82874Z","caller":"traceutil/trace.go:171","msg":"trace[1653595718] transaction","detail":"{read_only:false; response_revision:5579; number_of_response:1; }","duration":"172.183901ms","start":"2026-09-08T23:00:07.656522Z","end":"2026-09-08T23:00:07.828705Z","steps":["trace[1653595718] 'process raft request' (duration: 136.008075ms)","trace[1653595718] 'compare' (duration: 35.876909ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:00:07.828936Z","caller":"traceutil/trace.go:171","msg":"trace[1890809408] linearizableReadLoop","detail":"{readStateIndex:5792; appliedIndex:5790; }","duration":"168.005042ms","start":"2026-09-08T23:00:07.660903Z","end":"2026-09-08T23:00:07.828908Z","steps":["trace[1890809408] 'read index received' (duration: 71.362821ms)","trace[1890809408] 'applied index is now lower than readState.Index' (duration: 96.638571ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:00:07.829013Z","caller":"traceutil/trace.go:171","msg":"trace[40095840] transaction","detail":"{read_only:false; response_revision:5580; number_of_response:1; }","duration":"128.938194ms","start":"2026-09-08T23:00:07.700052Z","end":"2026-09-08T23:00:07.82899Z","steps":["trace[40095840] 'process raft request' (duration: 128.600087ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:00:07.829114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.184496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-08T23:00:07.829203Z","caller":"traceutil/trace.go:171","msg":"trace[1706816813] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:5581; }","duration":"168.305318ms","start":"2026-09-08T23:00:07.660877Z","end":"2026-09-08T23:00:07.829182Z","steps":["trace[1706816813] 'agreement among raft nodes before linearized reading' (duration: 168.105654ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:00:07.828875Z","caller":"traceutil/trace.go:171","msg":"trace[377508827] transaction","detail":"{read_only:false; number_of_response:1; response_revision:5579; }","duration":"171.390283ms","start":"2026-09-08T23:00:07.657446Z","end":"2026-09-08T23:00:07.828837Z","steps":["trace[377508827] 'process raft request' (duration: 171.162779ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:00:08.464749Z","caller":"traceutil/trace.go:171","msg":"trace[438096457] transaction","detail":"{read_only:false; response_revision:5587; number_of_response:1; }","duration":"427.428442ms","start":"2026-09-08T23:00:08.037289Z","end":"2026-09-08T23:00:08.464718Z","steps":["trace[438096457] 'process raft request' (duration: 427.209608ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:00:08.464926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:00:08.037271Z","time spent":"427.561365ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8041,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T23:00:08.643889Z","caller":"traceutil/trace.go:171","msg":"trace[1304653572] linearizableReadLoop","detail":"{readStateIndex:5801; appliedIndex:5799; }","duration":"452.247483ms","start":"2026-09-08T23:00:08.191615Z","end":"2026-09-08T23:00:08.643863Z","steps":["trace[1304653572] 'read index received' (duration: 272.775717ms)","trace[1304653572] 'applied index is now lower than readState.Index' (duration: 179.470326ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:00:08.644048Z","caller":"traceutil/trace.go:171","msg":"trace[103492104] transaction","detail":"{read_only:false; response_revision:5588; number_of_response:1; }","duration":"581.382952ms","start":"2026-09-08T23:00:08.062592Z","end":"2026-09-08T23:00:08.643975Z","steps":["trace[103492104] 'process raft request' (duration: 581.032404ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:00:08.644203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.582611ms","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-08T23:00:08.644234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:00:08.062565Z","time spent":"581.583577ms","remote":"127.0.0.1:50390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2585,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-08T23:00:08.644265Z","caller":"traceutil/trace.go:171","msg":"trace[1116513305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5589; }","duration":"452.699334ms","start":"2026-09-08T23:00:08.191553Z","end":"2026-09-08T23:00:08.644253Z","steps":["trace[1116513305] 'agreement among raft nodes before linearized reading' (duration: 452.427858ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:00:08.64434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:00:08.191505Z","time spent":"452.826736ms","remote":"127.0.0.1:50538","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-08T23:00:08.644659Z","caller":"traceutil/trace.go:171","msg":"trace[695713073] transaction","detail":"{read_only:false; response_revision:5589; number_of_response:1; }","duration":"200.337974ms","start":"2026-09-08T23:00:08.44423Z","end":"2026-09-08T23:00:08.644568Z","steps":["trace[695713073] 'process raft request' (duration: 199.550227ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:00:08.664197Z","caller":"traceutil/trace.go:171","msg":"trace[1429430675] transaction","detail":"{read_only:false; response_revision:5590; number_of_response:1; }","duration":"192.911225ms","start":"2026-09-08T23:00:08.471257Z","end":"2026-09-08T23:00:08.664168Z","steps":["trace[1429430675] 'process raft request' (duration: 192.733771ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:00:08.664595Z","caller":"traceutil/trace.go:171","msg":"trace[462029094] transaction","detail":"{read_only:false; response_revision:5591; number_of_response:1; }","duration":"191.940015ms","start":"2026-09-08T23:00:08.472621Z","end":"2026-09-08T23:00:08.664561Z","steps":["trace[462029094] 'process raft request' (duration: 191.501585ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:00:08.664631Z","caller":"traceutil/trace.go:171","msg":"trace[599470277] transaction","detail":"{read_only:false; response_revision:5592; number_of_response:1; }","duration":"191.466875ms","start":"2026-09-08T23:00:08.473133Z","end":"2026-09-08T23:00:08.664599Z","steps":["trace[599470277] 'process raft request' (duration: 191.26353ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:00:08.664842Z","caller":"traceutil/trace.go:171","msg":"trace[1319201392] transaction","detail":"{read_only:false; response_revision:5593; number_of_response:1; }","duration":"191.542516ms","start":"2026-09-08T23:00:08.473288Z","end":"2026-09-08T23:00:08.66483Z","steps":["trace[1319201392] 'process raft request' (duration: 191.2464ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:00:08.665033Z","caller":"traceutil/trace.go:171","msg":"trace[110672930] transaction","detail":"{read_only:false; response_revision:5594; number_of_response:1; }","duration":"171.750471ms","start":"2026-09-08T23:00:08.493265Z","end":"2026-09-08T23:00:08.665016Z","steps":["trace[110672930] 'process raft request' (duration: 171.415094ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:00:08.665224Z","caller":"traceutil/trace.go:171","msg":"trace[263948756] transaction","detail":"{read_only:false; response_revision:5595; number_of_response:1; }","duration":"169.443293ms","start":"2026-09-08T23:00:08.495745Z","end":"2026-09-08T23:00:08.665189Z","steps":["trace[263948756] 'process raft request' (duration: 169.032824ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:00:08.665373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.375359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T23:00:08.665426Z","caller":"traceutil/trace.go:171","msg":"trace[1839390909] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5595; }","duration":"175.488672ms","start":"2026-09-08T23:00:08.489922Z","end":"2026-09-08T23:00:08.66541Z","steps":["trace[1839390909] 'agreement among raft nodes before linearized reading' (duration: 175.39452ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:00:08.665443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.027745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5ghd6\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-09-08T23:00:08.665496Z","caller":"traceutil/trace.go:171","msg":"trace[559737266] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5ghd6; range_end:; response_count:1; response_revision:5595; }","duration":"344.120657ms","start":"2026-09-08T23:00:08.32136Z","end":"2026-09-08T23:00:08.665481Z","steps":["trace[559737266] 'agreement among raft nodes before linearized reading' (duration: 343.936373ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:00:08.665572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:00:08.321334Z","time spent":"344.224639ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6547,"request content":"key:\"/registry/pods/openstack/keepalived-5ghd6\" "} {"level":"info","ts":"2026-09-08T23:00:21.612343Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2964} {"level":"info","ts":"2026-09-08T23:00:21.68305Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2964,"took":"69.232745ms","hash":1751830222,"current-db-size-bytes":56012800,"current-db-size":"56 MB","current-db-size-in-use-bytes":32088064,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-08T23:00:21.683118Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1751830222,"revision":2964,"compact-revision":-1} {"level":"info","ts":"2026-09-08T23:05:21.620941Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5770} {"level":"info","ts":"2026-09-08T23:05:21.714205Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5770,"took":"91.367876ms","hash":3746142189,"current-db-size-bytes":56012800,"current-db-size":"56 MB","current-db-size-in-use-bytes":26103808,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-08T23:05:21.714279Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3746142189,"revision":5770,"compact-revision":2964} {"level":"info","ts":"2026-09-08T23:07:12.500214Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023b3.wal"} {"level":"info","ts":"2026-09-08T23:07:27.645282Z","caller":"traceutil/trace.go:171","msg":"trace[1385741426] transaction","detail":"{read_only:false; response_revision:8903; number_of_response:1; }","duration":"102.4573ms","start":"2026-09-08T23:07:27.542765Z","end":"2026-09-08T23:07:27.645222Z","steps":["trace[1385741426] 'process raft request' (duration: 57.324186ms)","trace[1385741426] 'compare' (duration: 45.000891ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:07:28.305353Z","caller":"traceutil/trace.go:171","msg":"trace[62700839] transaction","detail":"{read_only:false; response_revision:8906; number_of_response:1; }","duration":"193.610749ms","start":"2026-09-08T23:07:28.111717Z","end":"2026-09-08T23:07:28.305327Z","steps":["trace[62700839] 'process raft request' (duration: 193.446004ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:07:28.404683Z","caller":"traceutil/trace.go:171","msg":"trace[1274099471] transaction","detail":"{read_only:false; response_revision:8907; number_of_response:1; }","duration":"141.915483ms","start":"2026-09-08T23:07:28.262712Z","end":"2026-09-08T23:07:28.404627Z","steps":["trace[1274099471] 'process raft request' (duration: 141.512415ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:07:28.40487Z","caller":"traceutil/trace.go:171","msg":"trace[1562070626] transaction","detail":"{read_only:false; response_revision:8908; number_of_response:1; }","duration":"141.316029ms","start":"2026-09-08T23:07:28.263498Z","end":"2026-09-08T23:07:28.404814Z","steps":["trace[1562070626] 'process raft request' (duration: 140.932591ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:07:29.287025Z","caller":"traceutil/trace.go:171","msg":"trace[433478746] linearizableReadLoop","detail":"{readStateIndex:9229; appliedIndex:9228; }","duration":"237.588118ms","start":"2026-09-08T23:07:29.049413Z","end":"2026-09-08T23:07:29.287001Z","steps":["trace[433478746] 'read index received' (duration: 237.369683ms)","trace[433478746] 'applied index is now lower than readState.Index' (duration: 217.585µs)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:07:29.287328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.886024ms","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-08T23:07:29.287401Z","caller":"traceutil/trace.go:171","msg":"trace[769926147] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8911; }","duration":"237.988226ms","start":"2026-09-08T23:07:29.049396Z","end":"2026-09-08T23:07:29.287384Z","steps":["trace[769926147] 'agreement among raft nodes before linearized reading' (duration: 237.774711ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:07:29.287445Z","caller":"traceutil/trace.go:171","msg":"trace[1653533297] transaction","detail":"{read_only:false; response_revision:8911; number_of_response:1; }","duration":"307.198846ms","start":"2026-09-08T23:07:28.980187Z","end":"2026-09-08T23:07:29.287386Z","steps":["trace[1653533297] 'process raft request' (duration: 306.663105ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:07:29.287687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:07:28.98016Z","time spent":"307.41033ms","remote":"127.0.0.1:50538","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-09-08T23:07:29.795776Z","caller":"traceutil/trace.go:171","msg":"trace[1242185001] linearizableReadLoop","detail":"{readStateIndex:9231; appliedIndex:9230; }","duration":"125.890951ms","start":"2026-09-08T23:07:29.669864Z","end":"2026-09-08T23:07:29.795755Z","steps":["trace[1242185001] 'read index received' (duration: 125.768388ms)","trace[1242185001] 'applied index is now lower than readState.Index' (duration: 121.673µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:07:29.795834Z","caller":"traceutil/trace.go:171","msg":"trace[706818566] transaction","detail":"{read_only:false; response_revision:8913; number_of_response:1; }","duration":"143.536248ms","start":"2026-09-08T23:07:29.652276Z","end":"2026-09-08T23:07:29.795813Z","steps":["trace[706818566] 'process raft request' (duration: 143.333333ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:07:29.796012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.124446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-08T23:07:29.796069Z","caller":"traceutil/trace.go:171","msg":"trace[813469720] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8913; }","duration":"126.236148ms","start":"2026-09-08T23:07:29.66982Z","end":"2026-09-08T23:07:29.796057Z","steps":["trace[813469720] 'agreement among raft nodes before linearized reading' (duration: 126.057565ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:07:29.815856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.031698ms","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-08T23:07:29.81591Z","caller":"traceutil/trace.go:171","msg":"trace[15799756] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8914; }","duration":"115.116201ms","start":"2026-09-08T23:07:29.700782Z","end":"2026-09-08T23:07:29.815898Z","steps":["trace[15799756] 'agreement among raft nodes before linearized reading' (duration: 114.975118ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:07:30.033031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.683529ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-08T23:07:30.03334Z","caller":"traceutil/trace.go:171","msg":"trace[1969394828] transaction","detail":"{read_only:false; response_revision:8915; number_of_response:1; }","duration":"233.140012ms","start":"2026-09-08T23:07:29.800163Z","end":"2026-09-08T23:07:30.033303Z","steps":["trace[1969394828] 'process raft request' (duration: 61.078885ms)","trace[1969394828] 'compare' (duration: 171.532746ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:07:30.033354Z","caller":"traceutil/trace.go:171","msg":"trace[651878007] transaction","detail":"{read_only:false; response_revision:8916; number_of_response:1; }","duration":"213.912491ms","start":"2026-09-08T23:07:29.819396Z","end":"2026-09-08T23:07:30.033309Z","steps":["trace[651878007] 'process raft request' (duration: 213.755048ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:07:30.345312Z","caller":"traceutil/trace.go:171","msg":"trace[234030971] transaction","detail":"{read_only:false; response_revision:8917; number_of_response:1; }","duration":"167.621622ms","start":"2026-09-08T23:07:30.177653Z","end":"2026-09-08T23:07:30.345275Z","steps":["trace[234030971] 'process raft request' (duration: 167.328026ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:07:59.899031Z","caller":"traceutil/trace.go:171","msg":"trace[1536535137] transaction","detail":"{read_only:false; response_revision:9130; number_of_response:1; }","duration":"266.619378ms","start":"2026-09-08T23:07:59.632387Z","end":"2026-09-08T23:07:59.899007Z","steps":["trace[1536535137] 'process raft request' (duration: 266.487295ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:08:00.112642Z","caller":"traceutil/trace.go:171","msg":"trace[1120387144] linearizableReadLoop","detail":"{readStateIndex:9458; appliedIndex:9457; }","duration":"165.188091ms","start":"2026-09-08T23:07:59.947427Z","end":"2026-09-08T23:08:00.112615Z","steps":["trace[1120387144] 'read index received' (duration: 162.36145ms)","trace[1120387144] 'applied index is now lower than readState.Index' (duration: 2.825391ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:08:00.112928Z","caller":"traceutil/trace.go:171","msg":"trace[1220505349] transaction","detail":"{read_only:false; response_revision:9131; number_of_response:1; }","duration":"284.735006ms","start":"2026-09-08T23:07:59.828178Z","end":"2026-09-08T23:08:00.112913Z","steps":["trace[1220505349] 'process raft request' (duration: 281.606049ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:08:00.113203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.761163ms","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-08T23:08:00.113244Z","caller":"traceutil/trace.go:171","msg":"trace[1546213554] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9131; }","duration":"165.923466ms","start":"2026-09-08T23:07:59.947307Z","end":"2026-09-08T23:08:00.113231Z","steps":["trace[1546213554] 'agreement among raft nodes before linearized reading' (duration: 165.788463ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:08:00.11343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.333219ms","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-08T23:08:00.113463Z","caller":"traceutil/trace.go:171","msg":"trace[911170686] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9131; }","duration":"154.388399ms","start":"2026-09-08T23:07:59.959066Z","end":"2026-09-08T23:08:00.113454Z","steps":["trace[911170686] 'agreement among raft nodes before linearized reading' (duration: 154.301167ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:08:02.331964Z","caller":"traceutil/trace.go:171","msg":"trace[16929237] linearizableReadLoop","detail":"{readStateIndex:9472; appliedIndex:9471; }","duration":"103.098043ms","start":"2026-09-08T23:08:02.228842Z","end":"2026-09-08T23:08:02.33194Z","steps":["trace[16929237] 'read index received' (duration: 96.061633ms)","trace[16929237] 'applied index is now lower than readState.Index' (duration: 7.03521ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:08:02.332078Z","caller":"traceutil/trace.go:171","msg":"trace[1952342189] transaction","detail":"{read_only:false; response_revision:9144; number_of_response:1; }","duration":"107.513097ms","start":"2026-09-08T23:08:02.224527Z","end":"2026-09-08T23:08:02.33204Z","steps":["trace[1952342189] 'process raft request' (duration: 100.414825ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:08:02.332165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.297947ms","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-08T23:08:02.332212Z","caller":"traceutil/trace.go:171","msg":"trace[2093587605] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9144; }","duration":"103.427811ms","start":"2026-09-08T23:08:02.228773Z","end":"2026-09-08T23:08:02.332201Z","steps":["trace[2093587605] 'agreement among raft nodes before linearized reading' (duration: 103.262827ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:08:10.375162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.284274ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-08T23:08:10.375284Z","caller":"traceutil/trace.go:171","msg":"trace[2085534337] linearizableReadLoop","detail":"{readStateIndex:9514; appliedIndex:9513; }","duration":"164.816802ms","start":"2026-09-08T23:08:10.210448Z","end":"2026-09-08T23:08:10.375265Z","steps":["trace[2085534337] 'read index received' (duration: 27.439816ms)","trace[2085534337] 'applied index is now lower than readState.Index' (duration: 137.375436ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:08:10.375514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.013077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-08T23:08:10.375573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.551348ms","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-08T23:08:10.375621Z","caller":"traceutil/trace.go:171","msg":"trace[1075394392] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9184; }","duration":"128.634779ms","start":"2026-09-08T23:08:10.246969Z","end":"2026-09-08T23:08:10.375604Z","steps":["trace[1075394392] 'agreement among raft nodes before linearized reading' (duration: 128.414554ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:08:10.375618Z","caller":"traceutil/trace.go:171","msg":"trace[88809481] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:9184; }","duration":"165.193531ms","start":"2026-09-08T23:08:10.210397Z","end":"2026-09-08T23:08:10.375591Z","steps":["trace[88809481] 'agreement among raft nodes before linearized reading' (duration: 164.937785ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:08:10.676032Z","caller":"traceutil/trace.go:171","msg":"trace[1808657382] transaction","detail":"{read_only:false; response_revision:9189; number_of_response:1; }","duration":"103.231825ms","start":"2026-09-08T23:08:10.572759Z","end":"2026-09-08T23:08:10.675991Z","steps":["trace[1808657382] 'process raft request' (duration: 103.003851ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:08:10.67612Z","caller":"traceutil/trace.go:171","msg":"trace[380022795] transaction","detail":"{read_only:false; response_revision:9190; number_of_response:1; }","duration":"103.218236ms","start":"2026-09-08T23:08:10.57285Z","end":"2026-09-08T23:08:10.676068Z","steps":["trace[380022795] 'process raft request' (duration: 103.047972ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:08:13.203916Z","caller":"traceutil/trace.go:171","msg":"trace[1348705718] linearizableReadLoop","detail":"{readStateIndex:9543; appliedIndex:9542; }","duration":"153.893439ms","start":"2026-09-08T23:08:13.049999Z","end":"2026-09-08T23:08:13.203893Z","steps":["trace[1348705718] 'read index received' (duration: 5.365574ms)","trace[1348705718] 'applied index is now lower than readState.Index' (duration: 148.526945ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:08:13.20409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.070442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-r7gtq\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-09-08T23:08:13.204128Z","caller":"traceutil/trace.go:171","msg":"trace[512696763] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-r7gtq; range_end:; response_count:1; response_revision:9214; }","duration":"154.154344ms","start":"2026-09-08T23:08:13.049964Z","end":"2026-09-08T23:08:13.204118Z","steps":["trace[512696763] 'agreement among raft nodes before linearized reading' (duration: 154.020312ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:08:13.204428Z","caller":"traceutil/trace.go:171","msg":"trace[932378942] transaction","detail":"{read_only:false; response_revision:9213; number_of_response:1; }","duration":"164.869944ms","start":"2026-09-08T23:08:13.039547Z","end":"2026-09-08T23:08:13.204417Z","steps":["trace[932378942] 'process raft request' (duration: 164.144339ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:08:13.204681Z","caller":"traceutil/trace.go:171","msg":"trace[269832327] transaction","detail":"{read_only:false; response_revision:9214; number_of_response:1; }","duration":"153.597793ms","start":"2026-09-08T23:08:13.051051Z","end":"2026-09-08T23:08:13.204649Z","steps":["trace[269832327] 'process raft request' (duration: 152.780325ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:09:00.845406Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"2f0e00eb3c3ee1b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-08T23:09:00.85266Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-09-08T23:09:00.852764Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"warn","ts":"2026-09-08T23:09:41.118059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.229673ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-08T23:09:41.118247Z","caller":"traceutil/trace.go:171","msg":"trace[1089240605] transaction","detail":"{read_only:false; response_revision:10053; number_of_response:1; }","duration":"143.618355ms","start":"2026-09-08T23:09:40.974617Z","end":"2026-09-08T23:09:41.118235Z","steps":["trace[1089240605] 'process raft request' (duration: 143.595794ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:09:41.118336Z","caller":"traceutil/trace.go:171","msg":"trace[1060378856] transaction","detail":"{read_only:false; response_revision:10052; number_of_response:1; }","duration":"144.930723ms","start":"2026-09-08T23:09:40.973396Z","end":"2026-09-08T23:09:41.118327Z","steps":["trace[1060378856] 'process raft request' (duration: 144.784518ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:09:41.1184Z","caller":"traceutil/trace.go:171","msg":"trace[930363550] transaction","detail":"{read_only:false; response_revision:10051; number_of_response:1; }","duration":"196.128911ms","start":"2026-09-08T23:09:40.922263Z","end":"2026-09-08T23:09:41.118392Z","steps":["trace[930363550] 'process raft request' (duration: 93.493588ms)","trace[930363550] 'compare' (duration: 102.036299ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:09:41.1183Z","caller":"traceutil/trace.go:171","msg":"trace[1386846237] linearizableReadLoop","detail":"{readStateIndex:10408; appliedIndex:10407; }","duration":"165.459809ms","start":"2026-09-08T23:09:40.952799Z","end":"2026-09-08T23:09:41.118258Z","steps":["trace[1386846237] 'read index received' (duration: 62.906538ms)","trace[1386846237] 'applied index is now lower than readState.Index' (duration: 102.549601ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:09:41.118822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.005781ms","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-08T23:09:41.118977Z","caller":"traceutil/trace.go:171","msg":"trace[516384580] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:10053; }","duration":"166.204035ms","start":"2026-09-08T23:09:40.952748Z","end":"2026-09-08T23:09:41.118952Z","steps":["trace[516384580] 'agreement among raft nodes before linearized reading' (duration: 165.889148ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:09:41.433229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.32333ms","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-09-08T23:09:41.43333Z","caller":"traceutil/trace.go:171","msg":"trace[1192498209] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:10056; }","duration":"192.472503ms","start":"2026-09-08T23:09:41.240823Z","end":"2026-09-08T23:09:41.433295Z","steps":["trace[1192498209] 'count revisions from in-memory index tree' (duration: 192.213068ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:10:21.628357Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7954} {"level":"info","ts":"2026-09-08T23:10:21.69309Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7954,"took":"62.628441ms","hash":2471241800,"current-db-size-bytes":56012800,"current-db-size":"56 MB","current-db-size-in-use-bytes":27709440,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-08T23:10:21.693148Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2471241800,"revision":7954,"compact-revision":5770} {"level":"info","ts":"2026-09-08T23:15:21.745895Z","caller":"traceutil/trace.go:171","msg":"trace[973438412] transaction","detail":"{read_only:false; response_revision:12496; number_of_response:1; }","duration":"157.622566ms","start":"2026-09-08T23:15:21.588245Z","end":"2026-09-08T23:15:21.745867Z","steps":["trace[973438412] 'process raft request' (duration: 157.434893ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:15:21.781301Z","caller":"traceutil/trace.go:171","msg":"trace[2015889179] transaction","detail":"{read_only:false; response_revision:12497; number_of_response:1; }","duration":"151.449955ms","start":"2026-09-08T23:15:21.629806Z","end":"2026-09-08T23:15:21.781256Z","steps":["trace[2015889179] 'process raft request' (duration: 132.80367ms)","trace[2015889179] 'compare' (duration: 18.460481ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:15:21.852616Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10354} {"level":"warn","ts":"2026-09-08T23:15:22.322975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.787914ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-08T23:15:22.32314Z","caller":"traceutil/trace.go:171","msg":"trace[690201439] linearizableReadLoop","detail":"{readStateIndex:12935; appliedIndex:12934; }","duration":"252.142063ms","start":"2026-09-08T23:15:22.07098Z","end":"2026-09-08T23:15:22.323122Z","steps":["trace[690201439] 'read index received' (duration: 58.891µs)","trace[690201439] 'applied index is now lower than readState.Index' (duration: 252.081942ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:15:22.323173Z","caller":"traceutil/trace.go:171","msg":"trace[1934726417] transaction","detail":"{read_only:false; response_revision:12499; number_of_response:1; }","duration":"467.782832ms","start":"2026-09-08T23:15:21.855362Z","end":"2026-09-08T23:15:22.323145Z","steps":["trace[1934726417] 'process raft request' (duration: 21.721122ms)","trace[1934726417] 'compare' (duration: 445.619561ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:15:22.32325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.276476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T23:15:22.32328Z","caller":"traceutil/trace.go:171","msg":"trace[85347677] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12499; }","duration":"252.344217ms","start":"2026-09-08T23:15:22.070927Z","end":"2026-09-08T23:15:22.323271Z","steps":["trace[85347677] 'agreement among raft nodes before linearized reading' (duration: 252.283186ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:15:22.32334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:15:21.85533Z","time spent":"467.920905ms","remote":"127.0.0.1:50366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T23:15:22.323565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.382107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-09-08T23:15:22.32376Z","caller":"traceutil/trace.go:171","msg":"trace[2065803390] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:12499; }","duration":"251.49923ms","start":"2026-09-08T23:15:22.072116Z","end":"2026-09-08T23:15:22.323615Z","steps":["trace[2065803390] 'agreement among raft nodes before linearized reading' (duration: 251.217994ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:15:22.323901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.573911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-08T23:15:22.3239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.598892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-08T23:15:22.3239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.642213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T23:15:22.323963Z","caller":"traceutil/trace.go:171","msg":"trace[2114512025] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12499; }","duration":"251.636732ms","start":"2026-09-08T23:15:22.072308Z","end":"2026-09-08T23:15:22.323945Z","steps":["trace[2114512025] 'agreement among raft nodes before linearized reading' (duration: 251.52948ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:15:22.323991Z","caller":"traceutil/trace.go:171","msg":"trace[1300820203] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12499; }","duration":"251.708324ms","start":"2026-09-08T23:15:22.07226Z","end":"2026-09-08T23:15:22.323968Z","steps":["trace[1300820203] 'agreement among raft nodes before linearized reading' (duration: 251.564071ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:15:22.323927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.190839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-08T23:15:22.324001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.773955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"} {"level":"info","ts":"2026-09-08T23:15:22.323999Z","caller":"traceutil/trace.go:171","msg":"trace[687343526] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12499; }","duration":"251.762835ms","start":"2026-09-08T23:15:22.072215Z","end":"2026-09-08T23:15:22.323978Z","steps":["trace[687343526] 'agreement among raft nodes before linearized reading' (duration: 251.615412ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:15:22.324045Z","caller":"traceutil/trace.go:171","msg":"trace[2069340670] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:12499; }","duration":"191.367692ms","start":"2026-09-08T23:15:22.132662Z","end":"2026-09-08T23:15:22.324029Z","steps":["trace[2069340670] 'agreement among raft nodes before linearized reading' (duration: 191.166118ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:15:22.324056Z","caller":"traceutil/trace.go:171","msg":"trace[196981305] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12499; }","duration":"251.847337ms","start":"2026-09-08T23:15:22.072191Z","end":"2026-09-08T23:15:22.324038Z","steps":["trace[196981305] 'agreement among raft nodes before linearized reading' (duration: 251.642873ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:15:22.706227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.855106ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-08T23:15:22.7065Z","caller":"traceutil/trace.go:171","msg":"trace[1187920657] linearizableReadLoop","detail":"{readStateIndex:12938; appliedIndex:12935; }","duration":"216.704352ms","start":"2026-09-08T23:15:22.489777Z","end":"2026-09-08T23:15:22.706481Z","steps":["trace[1187920657] 'read index received' (duration: 47.451438ms)","trace[1187920657] 'applied index is now lower than readState.Index' (duration: 169.228253ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:15:22.70652Z","caller":"traceutil/trace.go:171","msg":"trace[894152627] transaction","detail":"{read_only:false; response_revision:12500; number_of_response:1; }","duration":"234.098371ms","start":"2026-09-08T23:15:22.472347Z","end":"2026-09-08T23:15:22.706446Z","steps":["trace[894152627] 'process raft request' (duration: 64.890028ms)","trace[894152627] 'compare' (duration: 103.367225ms)","trace[894152627] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; req_size:538; } (duration: 65.348738ms)"],"step_count":3} {"level":"info","ts":"2026-09-08T23:15:22.706538Z","caller":"traceutil/trace.go:171","msg":"trace[1323133998] transaction","detail":"{read_only:false; response_revision:12501; number_of_response:1; }","duration":"227.187033ms","start":"2026-09-08T23:15:22.479314Z","end":"2026-09-08T23:15:22.706501Z","steps":["trace[1323133998] 'process raft request' (duration: 227.03368ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:15:22.70658Z","caller":"traceutil/trace.go:171","msg":"trace[1375459214] transaction","detail":"{read_only:false; response_revision:12502; number_of_response:1; }","duration":"219.667724ms","start":"2026-09-08T23:15:22.486879Z","end":"2026-09-08T23:15:22.706547Z","steps":["trace[1375459214] 'process raft request' (duration: 219.537912ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:15:22.706659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.287795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T23:15:22.706704Z","caller":"traceutil/trace.go:171","msg":"trace[31450033] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:12502; }","duration":"210.339836ms","start":"2026-09-08T23:15:22.496352Z","end":"2026-09-08T23:15:22.706691Z","steps":["trace[31450033] 'agreement among raft nodes before linearized reading' (duration: 210.255044ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:15:22.706845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.001198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T23:15:22.706998Z","caller":"traceutil/trace.go:171","msg":"trace[1347732428] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12502; }","duration":"217.242283ms","start":"2026-09-08T23:15:22.48973Z","end":"2026-09-08T23:15:22.706972Z","steps":["trace[1347732428] 'agreement among raft nodes before linearized reading' (duration: 216.868745ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:15:22.755224Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10354,"took":"899.843175ms","hash":2617438252,"current-db-size-bytes":56012800,"current-db-size":"56 MB","current-db-size-in-use-bytes":25571328,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-08T23:15:22.755317Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2617438252,"revision":10354,"compact-revision":7954} {"level":"info","ts":"2026-09-08T23:20:21.859397Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12497} {"level":"info","ts":"2026-09-08T23:20:21.93933Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12497,"took":"77.268908ms","hash":3493622634,"current-db-size-bytes":56012800,"current-db-size":"56 MB","current-db-size-in-use-bytes":26861568,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-08T23:20:21.939398Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3493622634,"revision":12497,"compact-revision":10354} {"level":"info","ts":"2026-09-08T23:21:24.706184Z","caller":"traceutil/trace.go:171","msg":"trace[2008881383] transaction","detail":"{read_only:false; response_revision:14950; number_of_response:1; }","duration":"139.145639ms","start":"2026-09-08T23:21:24.567019Z","end":"2026-09-08T23:21:24.706165Z","steps":["trace[2008881383] 'process raft request' (duration: 138.530066ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:21:47.753989Z","caller":"traceutil/trace.go:171","msg":"trace[460903754] transaction","detail":"{read_only:false; response_revision:15078; number_of_response:1; }","duration":"165.972291ms","start":"2026-09-08T23:21:47.587987Z","end":"2026-09-08T23:21:47.75396Z","steps":["trace[460903754] 'process raft request' (duration: 165.553512ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:21:56.351948Z","caller":"traceutil/trace.go:171","msg":"trace[213655667] transaction","detail":"{read_only:false; response_revision:15122; number_of_response:1; }","duration":"203.82358ms","start":"2026-09-08T23:21:56.148099Z","end":"2026-09-08T23:21:56.351922Z","steps":["trace[213655667] 'process raft request' (duration: 203.773339ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:21:56.351971Z","caller":"traceutil/trace.go:171","msg":"trace[167570613] transaction","detail":"{read_only:false; response_revision:15121; number_of_response:1; }","duration":"206.460526ms","start":"2026-09-08T23:21:56.14548Z","end":"2026-09-08T23:21:56.35194Z","steps":["trace[167570613] 'process raft request' (duration: 206.240091ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:22:05.187019Z","caller":"traceutil/trace.go:171","msg":"trace[1156748269] linearizableReadLoop","detail":"{readStateIndex:15713; appliedIndex:15712; }","duration":"153.890994ms","start":"2026-09-08T23:22:05.033098Z","end":"2026-09-08T23:22:05.186989Z","steps":["trace[1156748269] 'read index received' (duration: 75.720636ms)","trace[1156748269] 'applied index is now lower than readState.Index' (duration: 78.169178ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:22:05.187243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.107338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-08T23:22:05.187325Z","caller":"traceutil/trace.go:171","msg":"trace[1038100377] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:15182; }","duration":"154.256171ms","start":"2026-09-08T23:22:05.033049Z","end":"2026-09-08T23:22:05.187306Z","steps":["trace[1038100377] 'agreement among raft nodes before linearized reading' (duration: 154.088748ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:22:05.187179Z","caller":"traceutil/trace.go:171","msg":"trace[334962247] transaction","detail":"{read_only:false; response_revision:15182; number_of_response:1; }","duration":"216.433538ms","start":"2026-09-08T23:22:04.970686Z","end":"2026-09-08T23:22:05.187119Z","steps":["trace[334962247] 'process raft request' (duration: 138.179769ms)","trace[334962247] 'compare' (duration: 77.83034ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:22:06.002576Z","caller":"traceutil/trace.go:171","msg":"trace[1154282045] linearizableReadLoop","detail":"{readStateIndex:15718; appliedIndex:15717; }","duration":"215.446727ms","start":"2026-09-08T23:22:05.787102Z","end":"2026-09-08T23:22:06.002549Z","steps":["trace[1154282045] 'read index received' (duration: 215.199602ms)","trace[1154282045] 'applied index is now lower than readState.Index' (duration: 246.125µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:22:06.003Z","caller":"traceutil/trace.go:171","msg":"trace[1242741356] transaction","detail":"{read_only:false; response_revision:15186; number_of_response:1; }","duration":"233.003402ms","start":"2026-09-08T23:22:05.76996Z","end":"2026-09-08T23:22:06.002964Z","steps":["trace[1242741356] 'process raft request' (duration: 232.409719ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:22:06.003261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.332374ms","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-08T23:22:06.003346Z","caller":"traceutil/trace.go:171","msg":"trace[1542142268] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15186; }","duration":"118.513258ms","start":"2026-09-08T23:22:05.884814Z","end":"2026-09-08T23:22:06.003328Z","steps":["trace[1542142268] 'agreement among raft nodes before linearized reading' (duration: 118.10989ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:22:06.003345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.231543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-p7r96\" ","response":"range_response_count:1 size:12364"} {"level":"info","ts":"2026-09-08T23:22:06.003418Z","caller":"traceutil/trace.go:171","msg":"trace[959648614] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-p7r96; range_end:; response_count:1; response_revision:15186; }","duration":"216.358976ms","start":"2026-09-08T23:22:05.787045Z","end":"2026-09-08T23:22:06.003404Z","steps":["trace[959648614] 'agreement among raft nodes before linearized reading' (duration: 215.983698ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:22:06.156142Z","caller":"traceutil/trace.go:171","msg":"trace[1778891217] transaction","detail":"{read_only:false; response_revision:15187; number_of_response:1; }","duration":"148.56903ms","start":"2026-09-08T23:22:06.007543Z","end":"2026-09-08T23:22:06.156112Z","steps":["trace[1778891217] 'process raft request' (duration: 126.571771ms)","trace[1778891217] 'compare' (duration: 21.866036ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:22:06.170693Z","caller":"traceutil/trace.go:171","msg":"trace[1444342298] transaction","detail":"{read_only:false; response_revision:15188; number_of_response:1; }","duration":"151.628925ms","start":"2026-09-08T23:22:06.019048Z","end":"2026-09-08T23:22:06.170677Z","steps":["trace[1444342298] 'process raft request' (duration: 151.268228ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:22:16.458383Z","caller":"traceutil/trace.go:171","msg":"trace[1265952552] linearizableReadLoop","detail":"{readStateIndex:15892; appliedIndex:15891; }","duration":"196.018033ms","start":"2026-09-08T23:22:16.262333Z","end":"2026-09-08T23:22:16.458352Z","steps":["trace[1265952552] 'read index received' (duration: 195.765507ms)","trace[1265952552] 'applied index is now lower than readState.Index' (duration: 251.016µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:22:16.458731Z","caller":"traceutil/trace.go:171","msg":"trace[1433401669] transaction","detail":"{read_only:false; response_revision:15357; number_of_response:1; }","duration":"224.848877ms","start":"2026-09-08T23:22:16.233869Z","end":"2026-09-08T23:22:16.458718Z","steps":["trace[1433401669] 'process raft request' (duration: 224.221124ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:22:16.458944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.563364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T23:22:16.459085Z","caller":"traceutil/trace.go:171","msg":"trace[622701894] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:15357; }","duration":"196.778778ms","start":"2026-09-08T23:22:16.262267Z","end":"2026-09-08T23:22:16.459045Z","steps":["trace[622701894] 'agreement among raft nodes before linearized reading' (duration: 196.502522ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:22:16.764581Z","caller":"traceutil/trace.go:171","msg":"trace[240259187] transaction","detail":"{read_only:false; response_revision:15358; number_of_response:1; }","duration":"452.25455ms","start":"2026-09-08T23:22:16.312299Z","end":"2026-09-08T23:22:16.764554Z","steps":["trace[240259187] 'process raft request' (duration: 441.795377ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:22:16.764744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:22:16.312265Z","time spent":"452.393892ms","remote":"127.0.0.1:50538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T23:22:16.764833Z","caller":"traceutil/trace.go:171","msg":"trace[2025413794] transaction","detail":"{read_only:false; response_revision:15359; number_of_response:1; }","duration":"326.923325ms","start":"2026-09-08T23:22:16.437855Z","end":"2026-09-08T23:22:16.764779Z","steps":["trace[2025413794] 'process raft request' (duration: 326.641789ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:22:16.764897Z","caller":"traceutil/trace.go:171","msg":"trace[908521702] transaction","detail":"{read_only:false; response_revision:15360; number_of_response:1; }","duration":"324.291398ms","start":"2026-09-08T23:22:16.440574Z","end":"2026-09-08T23:22:16.764866Z","steps":["trace[908521702] 'process raft request' (duration: 324.108675ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:22:16.765053Z","caller":"traceutil/trace.go:171","msg":"trace[849654769] linearizableReadLoop","detail":"{readStateIndex:15896; appliedIndex:15892; }","duration":"306.556861ms","start":"2026-09-08T23:22:16.458483Z","end":"2026-09-08T23:22:16.76504Z","steps":["trace[849654769] 'read index received' (duration: 295.552687ms)","trace[849654769] 'applied index is now lower than readState.Index' (duration: 11.002844ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:22:16.765081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:22:16.440544Z","time spent":"324.427892ms","remote":"127.0.0.1:50538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T23:22:16.765079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:22:16.437828Z","time spent":"327.133449ms","remote":"127.0.0.1:50366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":854,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-08T23:22:16.765235Z","caller":"traceutil/trace.go:171","msg":"trace[1128225983] transaction","detail":"{read_only:false; response_revision:15361; number_of_response:1; }","duration":"316.572115ms","start":"2026-09-08T23:22:16.448652Z","end":"2026-09-08T23:22:16.765224Z","steps":["trace[1128225983] 'process raft request' (duration: 316.159305ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:22:16.765305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:22:16.448621Z","time spent":"316.643827ms","remote":"127.0.0.1:50538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T23:22:16.765331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.579067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-08T23:22:16.765393Z","caller":"traceutil/trace.go:171","msg":"trace[202869254] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15361; }","duration":"272.645228ms","start":"2026-09-08T23:22:16.492732Z","end":"2026-09-08T23:22:16.765377Z","steps":["trace[202869254] 'agreement among raft nodes before linearized reading' (duration: 272.544596ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:22:16.765537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.463373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5ghd6\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-09-08T23:22:16.765614Z","caller":"traceutil/trace.go:171","msg":"trace[1172235793] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5ghd6; range_end:; response_count:1; response_revision:15361; }","duration":"458.597666ms","start":"2026-09-08T23:22:16.306997Z","end":"2026-09-08T23:22:16.765595Z","steps":["trace[1172235793] 'agreement among raft nodes before linearized reading' (duration: 458.276609ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:22:16.765669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:22:16.306971Z","time spent":"458.685917ms","remote":"127.0.0.1:50468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6547,"request content":"key:\"/registry/pods/openstack/keepalived-5ghd6\" "} {"level":"info","ts":"2026-09-08T23:25:21.867609Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14526} {"level":"info","ts":"2026-09-08T23:25:21.95673Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14526,"took":"86.671299ms","hash":2320385509,"current-db-size-bytes":56012800,"current-db-size":"56 MB","current-db-size-in-use-bytes":30920704,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-08T23:25:21.957489Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2320385509,"revision":14526,"compact-revision":12497} {"level":"info","ts":"2026-09-08T23:29:41.475333Z","caller":"traceutil/trace.go:171","msg":"trace[943327185] linearizableReadLoop","detail":"{readStateIndex:19626; appliedIndex:19625; }","duration":"208.201504ms","start":"2026-09-08T23:29:41.267105Z","end":"2026-09-08T23:29:41.475306Z","steps":["trace[943327185] 'read index received' (duration: 207.989199ms)","trace[943327185] 'applied index is now lower than readState.Index' (duration: 211.545µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:29:41.475658Z","caller":"traceutil/trace.go:171","msg":"trace[435478655] transaction","detail":"{read_only:false; response_revision:18974; number_of_response:1; }","duration":"210.869721ms","start":"2026-09-08T23:29:41.264775Z","end":"2026-09-08T23:29:41.475645Z","steps":["trace[435478655] 'process raft request' (duration: 210.37365ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:29:41.475964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.862657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-09-08T23:29:41.476011Z","caller":"traceutil/trace.go:171","msg":"trace[1974995282] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18974; }","duration":"208.951129ms","start":"2026-09-08T23:29:41.267048Z","end":"2026-09-08T23:29:41.475999Z","steps":["trace[1974995282] 'agreement among raft nodes before linearized reading' (duration: 208.800016ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:29:41.476177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.74029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-09-08T23:29:41.476259Z","caller":"traceutil/trace.go:171","msg":"trace[141083884] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18974; }","duration":"197.854502ms","start":"2026-09-08T23:29:41.278385Z","end":"2026-09-08T23:29:41.476239Z","steps":["trace[141083884] 'agreement among raft nodes before linearized reading' (duration: 197.603777ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:29:41.883236Z","caller":"traceutil/trace.go:171","msg":"trace[1243462802] linearizableReadLoop","detail":"{readStateIndex:19629; appliedIndex:19628; }","duration":"229.11636ms","start":"2026-09-08T23:29:41.654087Z","end":"2026-09-08T23:29:41.883203Z","steps":["trace[1243462802] 'read index received' (duration: 228.903356ms)","trace[1243462802] 'applied index is now lower than readState.Index' (duration: 211.974µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:29:41.883284Z","caller":"traceutil/trace.go:171","msg":"trace[368911108] transaction","detail":"{read_only:false; response_revision:18977; number_of_response:1; }","duration":"252.889348ms","start":"2026-09-08T23:29:41.630362Z","end":"2026-09-08T23:29:41.883251Z","steps":["trace[368911108] 'process raft request' (duration: 252.700034ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:29:41.883731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.618221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-mpftg\" ","response":"range_response_count:1 size:22094"} {"level":"info","ts":"2026-09-08T23:29:41.883796Z","caller":"traceutil/trace.go:171","msg":"trace[1158019595] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-mpftg; range_end:; response_count:1; response_revision:18977; }","duration":"229.724363ms","start":"2026-09-08T23:29:41.654054Z","end":"2026-09-08T23:29:41.883778Z","steps":["trace[1158019595] 'agreement among raft nodes before linearized reading' (duration: 229.272314ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:29:42.348881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.292725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-08T23:29:42.348964Z","caller":"traceutil/trace.go:171","msg":"trace[182797004] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:18977; }","duration":"155.405247ms","start":"2026-09-08T23:29:42.193535Z","end":"2026-09-08T23:29:42.34894Z","steps":["trace[182797004] 'count revisions from in-memory index tree' (duration: 155.209883ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:29:42.348967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.51885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-cxpd8\" ","response":"range_response_count:1 size:9789"} {"level":"info","ts":"2026-09-08T23:29:42.349042Z","caller":"traceutil/trace.go:171","msg":"trace[2096651609] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-cxpd8; range_end:; response_count:1; response_revision:18977; }","duration":"170.641092ms","start":"2026-09-08T23:29:42.178382Z","end":"2026-09-08T23:29:42.349023Z","steps":["trace[2096651609] 'range keys from in-memory index tree' (duration: 170.314545ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:30:15.641607Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"2f0e00eb3c3ee1b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-08T23:30:15.647268Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-09-08T23:30:15.647371Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-09-08T23:30:21.877802Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16990} {"level":"info","ts":"2026-09-08T23:30:21.982769Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16990,"took":"101.85312ms","hash":2572135313,"current-db-size-bytes":56012800,"current-db-size":"56 MB","current-db-size-in-use-bytes":32555008,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-09-08T23:30:21.982848Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2572135313,"revision":16990,"compact-revision":14526} {"level":"info","ts":"2026-09-08T23:35:21.885859Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19385} {"level":"info","ts":"2026-09-08T23:35:22.00502Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19385,"took":"115.685295ms","hash":609644904,"current-db-size-bytes":56012800,"current-db-size":"56 MB","current-db-size-in-use-bytes":30392320,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-09-08T23:35:22.005093Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":609644904,"revision":19385,"compact-revision":16990} {"level":"info","ts":"2026-09-08T23:35:57.538605Z","caller":"traceutil/trace.go:171","msg":"trace[716081122] linearizableReadLoop","detail":"{readStateIndex:22578; appliedIndex:22577; }","duration":"122.893059ms","start":"2026-09-08T23:35:57.415654Z","end":"2026-09-08T23:35:57.538547Z","steps":["trace[716081122] 'read index received' (duration: 122.642424ms)","trace[716081122] 'applied index is now lower than readState.Index' (duration: 249.355µs)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:35:57.538621Z","caller":"traceutil/trace.go:171","msg":"trace[924753566] transaction","detail":"{read_only:false; response_revision:21830; number_of_response:1; }","duration":"141.357045ms","start":"2026-09-08T23:35:57.397235Z","end":"2026-09-08T23:35:57.538592Z","steps":["trace[924753566] 'process raft request' (duration: 141.064299ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:35:57.538898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.217036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-09-08T23:35:57.538961Z","caller":"traceutil/trace.go:171","msg":"trace[160943195] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21830; }","duration":"123.322509ms","start":"2026-09-08T23:35:57.415622Z","end":"2026-09-08T23:35:57.538945Z","steps":["trace[160943195] 'agreement among raft nodes before linearized reading' (duration: 123.130175ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:35:57.538972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.000551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-09-08T23:35:57.539054Z","caller":"traceutil/trace.go:171","msg":"trace[1533447190] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21830; }","duration":"123.122685ms","start":"2026-09-08T23:35:57.415914Z","end":"2026-09-08T23:35:57.539036Z","steps":["trace[1533447190] 'agreement among raft nodes before linearized reading' (duration: 122.875199ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:35:57.860745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.938866ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-08T23:35:57.860978Z","caller":"traceutil/trace.go:171","msg":"trace[1065827285] transaction","detail":"{read_only:false; response_revision:21832; number_of_response:1; }","duration":"317.36103ms","start":"2026-09-08T23:35:57.543563Z","end":"2026-09-08T23:35:57.860924Z","steps":["trace[1065827285] 'process raft request' (duration: 197.093007ms)","trace[1065827285] 'compare' (duration: 119.829484ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:35:57.861136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:35:57.54354Z","time spent":"317.515284ms","remote":"127.0.0.1:50538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-08T23:35:58.067615Z","caller":"traceutil/trace.go:171","msg":"trace[2065227757] transaction","detail":"{read_only:false; response_revision:21834; number_of_response:1; }","duration":"134.345523ms","start":"2026-09-08T23:35:57.933244Z","end":"2026-09-08T23:35:58.067589Z","steps":["trace[2065227757] 'process raft request' (duration: 111.842572ms)","trace[2065227757] 'compare' (duration: 22.393239ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:35:58.23481Z","caller":"traceutil/trace.go:171","msg":"trace[1254969895] transaction","detail":"{read_only:false; response_revision:21835; number_of_response:1; }","duration":"300.165682ms","start":"2026-09-08T23:35:57.934615Z","end":"2026-09-08T23:35:58.23478Z","steps":["trace[1254969895] 'process raft request' (duration: 256.204361ms)","trace[1254969895] 'compare' (duration: 43.714716ms)"],"step_count":2} {"level":"info","ts":"2026-09-08T23:35:58.234765Z","caller":"traceutil/trace.go:171","msg":"trace[319257807] linearizableReadLoop","detail":"{readStateIndex:22583; appliedIndex:22581; }","duration":"292.032138ms","start":"2026-09-08T23:35:57.942704Z","end":"2026-09-08T23:35:58.234736Z","steps":["trace[319257807] 'read index received' (duration: 102.474892ms)","trace[319257807] 'applied index is now lower than readState.Index' (duration: 189.555826ms)"],"step_count":2} {"level":"warn","ts":"2026-09-08T23:35:58.23496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-08T23:35:57.934578Z","time spent":"300.296355ms","remote":"127.0.0.1:50538","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-08T23:35:58.234997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.273593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-08T23:35:58.234875Z","caller":"traceutil/trace.go:171","msg":"trace[1631378000] transaction","detail":"{read_only:false; response_revision:21836; number_of_response:1; }","duration":"207.878428ms","start":"2026-09-08T23:35:58.02693Z","end":"2026-09-08T23:35:58.234808Z","steps":["trace[1631378000] 'process raft request' (duration: 207.741535ms)"],"step_count":1} {"level":"warn","ts":"2026-09-08T23:35:58.235025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.948701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-08T23:35:58.235329Z","caller":"traceutil/trace.go:171","msg":"trace[24849987] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:21836; }","duration":"181.302998ms","start":"2026-09-08T23:35:58.054009Z","end":"2026-09-08T23:35:58.235312Z","steps":["trace[24849987] 'agreement among raft nodes before linearized reading' (duration: 180.948011ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:35:58.235092Z","caller":"traceutil/trace.go:171","msg":"trace[1090206612] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:21836; }","duration":"292.420236ms","start":"2026-09-08T23:35:57.942651Z","end":"2026-09-08T23:35:58.235071Z","steps":["trace[1090206612] 'agreement among raft nodes before linearized reading' (duration: 292.257663ms)"],"step_count":1} {"level":"info","ts":"2026-09-08T23:40:21.893404Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21652} {"level":"info","ts":"2026-09-08T23:40:22.003364Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21652,"took":"106.325941ms","hash":2332432583,"current-db-size-bytes":56012800,"current-db-size":"56 MB","current-db-size-in-use-bytes":42467328,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-09-08T23:40:22.003437Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2332432583,"revision":21652,"compact-revision":19385} {"level":"info","ts":"2026-09-08T23:44:14.62604Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006aef.wal"} {"level":"info","ts":"2026-09-08T23:45:21.904922Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24540} {"level":"info","ts":"2026-09-08T23:45:22.065561Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24540,"took":"156.588204ms","hash":3865406016,"current-db-size-bytes":56012800,"current-db-size":"56 MB","current-db-size-in-use-bytes":33427456,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-09-08T23:45:22.065656Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3865406016,"revision":24540,"compact-revision":21652} {"level":"info","ts":"2026-09-08T23:50:00.1377Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"2f0e00eb3c3ee1b","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-08T23:50:00.148856Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-09-08T23:50:00.149017Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-09-08T23:50:21.912295Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27009} {"level":"info","ts":"2026-09-08T23:50:22.035492Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27009,"took":"119.502582ms","hash":3597034306,"current-db-size-bytes":56012800,"current-db-size":"56 MB","current-db-size-in-use-bytes":29581312,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-09-08T23:50:22.035579Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3597034306,"revision":27009,"compact-revision":24540}