{"level":"warn","ts":"2026-10-14T19:41:53.412998Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-14T19:41:53.413111Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.66:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.66:2380","--initial-cluster=instance=https://199.204.45.66:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.66:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.66: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-10-14T19:41:53.41319Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-14T19:41:53.413207Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.66:2380"]} {"level":"info","ts":"2026-10-14T19:41:53.413232Z","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-10-14T19:41:53.41404Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.66:2379"]} {"level":"info","ts":"2026-10-14T19:41:53.414128Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.66:2380"],"listen-peer-urls":["https://199.204.45.66:2380"],"advertise-client-urls":["https://199.204.45.66:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.66:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.66: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-10-14T19:41:53.417029Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.635015ms"} {"level":"info","ts":"2026-10-14T19:41:53.423438Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1e882206af630b31","cluster-id":"d7272b46ecda333f"} {"level":"info","ts":"2026-10-14T19:41:53.423519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e882206af630b31 switched to configuration voters=()"} {"level":"info","ts":"2026-10-14T19:41:53.423541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e882206af630b31 became follower at term 0"} {"level":"info","ts":"2026-10-14T19:41:53.423555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1e882206af630b31 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-14T19:41:53.42357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e882206af630b31 became follower at term 1"} {"level":"info","ts":"2026-10-14T19:41:53.423616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e882206af630b31 switched to configuration voters=(2200045830078139185)"} {"level":"warn","ts":"2026-10-14T19:41:53.4314Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-14T19:41:53.43323Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-14T19:41:53.434684Z","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-10-14T19:41:53.437475Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1e882206af630b31","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-14T19:41:53.437718Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1e882206af630b31","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-14T19:41:53.437936Z","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-10-14T19:41:53.438127Z","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-10-14T19:41:53.438159Z","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-10-14T19:41:53.440315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e882206af630b31 switched to configuration voters=(2200045830078139185)"} {"level":"info","ts":"2026-10-14T19:41:53.440682Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d7272b46ecda333f","local-member-id":"1e882206af630b31","added-peer-id":"1e882206af630b31","added-peer-peer-urls":["https://199.204.45.66:2380"]} {"level":"info","ts":"2026-10-14T19:41:53.443329Z","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-10-14T19:41:53.443522Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.66:2380"} {"level":"info","ts":"2026-10-14T19:41:53.443633Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.66:2380"} {"level":"info","ts":"2026-10-14T19:41:53.443814Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1e882206af630b31","initial-advertise-peer-urls":["https://199.204.45.66:2380"],"listen-peer-urls":["https://199.204.45.66:2380"],"advertise-client-urls":["https://199.204.45.66:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.66:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-14T19:41:53.443935Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-14T19:41:54.324446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e882206af630b31 is starting a new election at term 1"} {"level":"info","ts":"2026-10-14T19:41:54.32454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e882206af630b31 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-14T19:41:54.324577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e882206af630b31 received MsgPreVoteResp from 1e882206af630b31 at term 1"} {"level":"info","ts":"2026-10-14T19:41:54.324599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e882206af630b31 became candidate at term 2"} {"level":"info","ts":"2026-10-14T19:41:54.32461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e882206af630b31 received MsgVoteResp from 1e882206af630b31 at term 2"} {"level":"info","ts":"2026-10-14T19:41:54.324627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1e882206af630b31 became leader at term 2"} {"level":"info","ts":"2026-10-14T19:41:54.324648Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1e882206af630b31 elected leader 1e882206af630b31 at term 2"} {"level":"info","ts":"2026-10-14T19:41:54.325821Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T19:41:54.326919Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T19:41:54.326925Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1e882206af630b31","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.66:2379]}","request-path":"/0/members/1e882206af630b31/attributes","cluster-id":"d7272b46ecda333f","publish-timeout":"7s"} {"level":"info","ts":"2026-10-14T19:41:54.32696Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T19:41:54.327216Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-14T19:41:54.327302Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-14T19:41:54.327437Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d7272b46ecda333f","local-member-id":"1e882206af630b31","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T19:41:54.32756Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T19:41:54.327604Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T19:41:54.330565Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-14T19:41:54.330601Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.66:2379"} {"level":"info","ts":"2026-10-14T19:42:02.608784Z","caller":"traceutil/trace.go:171","msg":"trace[530478583] linearizableReadLoop","detail":"{readStateIndex:307; appliedIndex:306; }","duration":"137.078558ms","start":"2026-10-14T19:42:02.471675Z","end":"2026-10-14T19:42:02.608753Z","steps":["trace[530478583] 'read index received' (duration: 136.855934ms)","trace[530478583] 'applied index is now lower than readState.Index' (duration: 221.644µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:42:02.609184Z","caller":"traceutil/trace.go:171","msg":"trace[145092687] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"187.761174ms","start":"2026-10-14T19:42:02.421384Z","end":"2026-10-14T19:42:02.609146Z","steps":["trace[145092687] 'process raft request' (duration: 187.216662ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:42:02.609145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.309124ms","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-10-14T19:42:02.609318Z","caller":"traceutil/trace.go:171","msg":"trace[1409439153] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:295; }","duration":"137.713902ms","start":"2026-10-14T19:42:02.47158Z","end":"2026-10-14T19:42:02.609294Z","steps":["trace[1409439153] 'agreement among raft nodes before linearized reading' (duration: 137.300163ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:03.05419Z","caller":"traceutil/trace.go:171","msg":"trace[2032084237] linearizableReadLoop","detail":"{readStateIndex:308; appliedIndex:307; }","duration":"437.870206ms","start":"2026-10-14T19:42:02.616251Z","end":"2026-10-14T19:42:03.054121Z","steps":["trace[2032084237] 'read index received' (duration: 437.59179ms)","trace[2032084237] 'applied index is now lower than readState.Index' (duration: 277.316µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:42:03.054244Z","caller":"traceutil/trace.go:171","msg":"trace[1922679080] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"439.392617ms","start":"2026-10-14T19:42:02.614805Z","end":"2026-10-14T19:42:03.054197Z","steps":["trace[1922679080] 'process raft request' (duration: 439.145022ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:42:03.054356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.07091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-10-14T19:42:03.054402Z","caller":"traceutil/trace.go:171","msg":"trace[1454134521] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:296; }","duration":"438.192162ms","start":"2026-10-14T19:42:02.616196Z","end":"2026-10-14T19:42:03.054388Z","steps":["trace[1454134521] 'agreement among raft nodes before linearized reading' (duration: 438.08133ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:42:03.054472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:42:02.616176Z","time spent":"438.286574ms","remote":"127.0.0.1:34930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-14T19:42:03.055051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:42:02.614781Z","time spent":"439.560751ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T19:42:03.192071Z","caller":"traceutil/trace.go:171","msg":"trace[1316772300] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"133.442743ms","start":"2026-10-14T19:42:03.058571Z","end":"2026-10-14T19:42:03.192014Z","steps":["trace[1316772300] 'process raft request' (duration: 118.720204ms)","trace[1316772300] 'compare' (duration: 14.507724ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:42:03.489655Z","caller":"traceutil/trace.go:171","msg":"trace[1642180663] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"255.987627ms","start":"2026-10-14T19:42:03.233645Z","end":"2026-10-14T19:42:03.489633Z","steps":["trace[1642180663] 'process raft request' (duration: 251.906051ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:03.491446Z","caller":"traceutil/trace.go:171","msg":"trace[336374326] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"252.33177ms","start":"2026-10-14T19:42:03.239012Z","end":"2026-10-14T19:42:03.491343Z","steps":["trace[336374326] 'process raft request' (duration: 252.080484ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:03.491475Z","caller":"traceutil/trace.go:171","msg":"trace[236357953] linearizableReadLoop","detail":"{readStateIndex:313; appliedIndex:309; }","duration":"219.261245ms","start":"2026-10-14T19:42:03.27218Z","end":"2026-10-14T19:42:03.491441Z","steps":["trace[236357953] 'read index received' (duration: 213.477113ms)","trace[236357953] 'applied index is now lower than readState.Index' (duration: 5.782842ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:42:03.491559Z","caller":"traceutil/trace.go:171","msg":"trace[1051518183] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"252.171566ms","start":"2026-10-14T19:42:03.239345Z","end":"2026-10-14T19:42:03.491517Z","steps":["trace[1051518183] 'process raft request' (duration: 251.926151ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:03.491579Z","caller":"traceutil/trace.go:171","msg":"trace[349101711] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"249.842077ms","start":"2026-10-14T19:42:03.241701Z","end":"2026-10-14T19:42:03.491543Z","steps":["trace[349101711] 'process raft request' (duration: 249.641183ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:42:03.491874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.68913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-10-14T19:42:03.491947Z","caller":"traceutil/trace.go:171","msg":"trace[1357427777] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:301; }","duration":"215.816173ms","start":"2026-10-14T19:42:03.276114Z","end":"2026-10-14T19:42:03.49193Z","steps":["trace[1357427777] 'agreement among raft nodes before linearized reading' (duration: 215.67471ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:42:03.491889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.675114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-10-14T19:42:03.49204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.719298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-10-14T19:42:03.492183Z","caller":"traceutil/trace.go:171","msg":"trace[569625296] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:301; }","duration":"113.937753ms","start":"2026-10-14T19:42:03.378214Z","end":"2026-10-14T19:42:03.492152Z","steps":["trace[569625296] 'agreement among raft nodes before linearized reading' (duration: 113.609426ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:03.49229Z","caller":"traceutil/trace.go:171","msg":"trace[1357819703] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:301; }","duration":"219.999731ms","start":"2026-10-14T19:42:03.272116Z","end":"2026-10-14T19:42:03.492115Z","steps":["trace[1357819703] 'agreement among raft nodes before linearized reading' (duration: 219.593162ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:42:03.49241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.288902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"warn","ts":"2026-10-14T19:42:03.4924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.72554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-10-14T19:42:03.49248Z","caller":"traceutil/trace.go:171","msg":"trace[785146915] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:301; }","duration":"215.398844ms","start":"2026-10-14T19:42:03.277065Z","end":"2026-10-14T19:42:03.492464Z","steps":["trace[785146915] 'agreement among raft nodes before linearized reading' (duration: 215.313712ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:42:03.492329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.347471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-10-14T19:42:03.492522Z","caller":"traceutil/trace.go:171","msg":"trace[927447561] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:301; }","duration":"214.887213ms","start":"2026-10-14T19:42:03.277614Z","end":"2026-10-14T19:42:03.492502Z","steps":["trace[927447561] 'agreement among raft nodes before linearized reading' (duration: 214.667118ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:42:03.492669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.8246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-10-14T19:42:03.492727Z","caller":"traceutil/trace.go:171","msg":"trace[46633154] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:301; }","duration":"113.715269ms","start":"2026-10-14T19:42:03.378912Z","end":"2026-10-14T19:42:03.492627Z","steps":["trace[46633154] 'agreement among raft nodes before linearized reading' (duration: 113.354011ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:03.4928Z","caller":"traceutil/trace.go:171","msg":"trace[1169800005] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:301; }","duration":"213.009914ms","start":"2026-10-14T19:42:03.279762Z","end":"2026-10-14T19:42:03.492772Z","steps":["trace[1169800005] 'agreement among raft nodes before linearized reading' (duration: 212.714458ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:38.137079Z","caller":"traceutil/trace.go:171","msg":"trace[1120798319] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"117.2772ms","start":"2026-10-14T19:42:38.019776Z","end":"2026-10-14T19:42:38.137053Z","steps":["trace[1120798319] 'process raft request' (duration: 117.161747ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:38.284216Z","caller":"traceutil/trace.go:171","msg":"trace[1324958199] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"258.457846ms","start":"2026-10-14T19:42:38.025739Z","end":"2026-10-14T19:42:38.284197Z","steps":["trace[1324958199] 'process raft request' (duration: 258.351313ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:38.284202Z","caller":"traceutil/trace.go:171","msg":"trace[1543441585] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"263.021568ms","start":"2026-10-14T19:42:38.02115Z","end":"2026-10-14T19:42:38.284172Z","steps":["trace[1543441585] 'process raft request' (duration: 262.854785ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:38.284355Z","caller":"traceutil/trace.go:171","msg":"trace[1391211295] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"246.115349ms","start":"2026-10-14T19:42:38.038229Z","end":"2026-10-14T19:42:38.284344Z","steps":["trace[1391211295] 'process raft request' (duration: 245.936835ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:38.28436Z","caller":"traceutil/trace.go:171","msg":"trace[1123444974] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"245.284591ms","start":"2026-10-14T19:42:38.039065Z","end":"2026-10-14T19:42:38.28435Z","steps":["trace[1123444974] 'process raft request' (duration: 245.206109ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:38.284342Z","caller":"traceutil/trace.go:171","msg":"trace[1662688819] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"248.38455ms","start":"2026-10-14T19:42:38.035904Z","end":"2026-10-14T19:42:38.284289Z","steps":["trace[1662688819] 'process raft request' (duration: 248.227186ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:38.284448Z","caller":"traceutil/trace.go:171","msg":"trace[1344678231] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"243.113982ms","start":"2026-10-14T19:42:38.041327Z","end":"2026-10-14T19:42:38.284441Z","steps":["trace[1344678231] 'process raft request' (duration: 242.986509ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:38.284493Z","caller":"traceutil/trace.go:171","msg":"trace[745062552] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"242.54479ms","start":"2026-10-14T19:42:38.041919Z","end":"2026-10-14T19:42:38.284463Z","steps":["trace[745062552] 'process raft request' (duration: 242.431697ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:38.284535Z","caller":"traceutil/trace.go:171","msg":"trace[2094354543] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"217.343304ms","start":"2026-10-14T19:42:38.067181Z","end":"2026-10-14T19:42:38.284524Z","steps":["trace[2094354543] 'process raft request' (duration: 217.211091ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:38.284586Z","caller":"traceutil/trace.go:171","msg":"trace[1167403540] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"204.474825ms","start":"2026-10-14T19:42:38.0801Z","end":"2026-10-14T19:42:38.284575Z","steps":["trace[1167403540] 'process raft request' (duration: 204.370593ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:38.284594Z","caller":"traceutil/trace.go:171","msg":"trace[1573259667] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"164.290795ms","start":"2026-10-14T19:42:38.120294Z","end":"2026-10-14T19:42:38.284585Z","steps":["trace[1573259667] 'process raft request' (duration: 164.229933ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:38.284636Z","caller":"traceutil/trace.go:171","msg":"trace[309798071] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:523; }","duration":"227.660905ms","start":"2026-10-14T19:42:38.056914Z","end":"2026-10-14T19:42:38.284575Z","steps":["trace[309798071] 'read index received' (duration: 80.037265ms)","trace[309798071] 'applied index is now lower than readState.Index' (duration: 147.6228ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:42:38.284749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.816309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-14T19:42:38.284793Z","caller":"traceutil/trace.go:171","msg":"trace[1616870839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:513; }","duration":"227.900651ms","start":"2026-10-14T19:42:38.056882Z","end":"2026-10-14T19:42:38.284782Z","steps":["trace[1616870839] 'agreement among raft nodes before linearized reading' (duration: 227.791258ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:38.292975Z","caller":"traceutil/trace.go:171","msg":"trace[1450825849] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"149.585814ms","start":"2026-10-14T19:42:38.143371Z","end":"2026-10-14T19:42:38.292957Z","steps":["trace[1450825849] 'process raft request' (duration: 149.183895ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:38.293623Z","caller":"traceutil/trace.go:171","msg":"trace[78788069] transaction","detail":"{read_only:false; number_of_response:1; response_revision:515; }","duration":"147.869976ms","start":"2026-10-14T19:42:38.145736Z","end":"2026-10-14T19:42:38.293606Z","steps":["trace[78788069] 'process raft request' (duration: 146.995556ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:38.293161Z","caller":"traceutil/trace.go:171","msg":"trace[164436605] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"148.551061ms","start":"2026-10-14T19:42:38.144587Z","end":"2026-10-14T19:42:38.293139Z","steps":["trace[164436605] 'process raft request' (duration: 148.091451ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:44.947912Z","caller":"traceutil/trace.go:171","msg":"trace[1433072607] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"185.237317ms","start":"2026-10-14T19:42:44.762643Z","end":"2026-10-14T19:42:44.94788Z","steps":["trace[1433072607] 'process raft request' (duration: 184.95394ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:45.993061Z","caller":"traceutil/trace.go:171","msg":"trace[1545296379] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"304.940326ms","start":"2026-10-14T19:42:45.688099Z","end":"2026-10-14T19:42:45.993039Z","steps":["trace[1545296379] 'read index received' (duration: 304.202579ms)","trace[1545296379] 'applied index is now lower than readState.Index' (duration: 736.817µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:42:45.99314Z","caller":"traceutil/trace.go:171","msg":"trace[1043816042] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"577.380065ms","start":"2026-10-14T19:42:45.415735Z","end":"2026-10-14T19:42:45.993115Z","steps":["trace[1043816042] 'process raft request' (duration: 576.829342ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:42:45.993265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.363103ms","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-10-14T19:42:45.993266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.14164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-14T19:42:45.993327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:42:45.415706Z","time spent":"577.517318ms","remote":"127.0.0.1:34916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T19:42:45.993385Z","caller":"traceutil/trace.go:171","msg":"trace[117432968] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"305.263643ms","start":"2026-10-14T19:42:45.688085Z","end":"2026-10-14T19:42:45.993348Z","steps":["trace[117432968] 'agreement among raft nodes before linearized reading' (duration: 305.071189ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:45.993315Z","caller":"traceutil/trace.go:171","msg":"trace[170526897] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:614; }","duration":"258.450055ms","start":"2026-10-14T19:42:45.734843Z","end":"2026-10-14T19:42:45.993293Z","steps":["trace[170526897] 'agreement among raft nodes before linearized reading' (duration: 258.314922ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:42:45.993476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:42:45.688027Z","time spent":"305.435676ms","remote":"127.0.0.1:34804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-14T19:42:47.446736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.41246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-10-14T19:42:47.446646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.740705ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T19:42:47.446811Z","caller":"traceutil/trace.go:171","msg":"trace[2134729365] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:628; }","duration":"213.928839ms","start":"2026-10-14T19:42:47.232868Z","end":"2026-10-14T19:42:47.446796Z","steps":["trace[2134729365] 'range keys from in-memory index tree' (duration: 213.700354ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:42:47.44681Z","caller":"traceutil/trace.go:171","msg":"trace[1258445041] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:628; }","duration":"105.524193ms","start":"2026-10-14T19:42:47.341265Z","end":"2026-10-14T19:42:47.446789Z","steps":["trace[1258445041] 'range keys from in-memory index tree' (duration: 105.252787ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:43:01.731685Z","caller":"traceutil/trace.go:171","msg":"trace[1379824806] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"196.10193ms","start":"2026-10-14T19:43:01.535561Z","end":"2026-10-14T19:43:01.731663Z","steps":["trace[1379824806] 'process raft request' (duration: 195.842564ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:43:32.113442Z","caller":"traceutil/trace.go:171","msg":"trace[1360991926] linearizableReadLoop","detail":"{readStateIndex:1217; appliedIndex:1216; }","duration":"151.404159ms","start":"2026-10-14T19:43:31.961945Z","end":"2026-10-14T19:43:32.113349Z","steps":["trace[1360991926] 'read index received' (duration: 151.090212ms)","trace[1360991926] 'applied index is now lower than readState.Index' (duration: 312.557µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:43:32.113478Z","caller":"traceutil/trace.go:171","msg":"trace[1024690071] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"190.062956ms","start":"2026-10-14T19:43:31.923337Z","end":"2026-10-14T19:43:32.1134Z","steps":["trace[1024690071] 'process raft request' (duration: 189.825ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:43:32.113723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.747287ms","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-10-14T19:43:32.113808Z","caller":"traceutil/trace.go:171","msg":"trace[83511575] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1180; }","duration":"151.88731ms","start":"2026-10-14T19:43:31.961903Z","end":"2026-10-14T19:43:32.11379Z","steps":["trace[83511575] 'agreement among raft nodes before linearized reading' (duration: 151.623804ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:43:48.321889Z","caller":"traceutil/trace.go:171","msg":"trace[1366013093] linearizableReadLoop","detail":"{readStateIndex:1364; appliedIndex:1363; }","duration":"106.41219ms","start":"2026-10-14T19:43:48.215442Z","end":"2026-10-14T19:43:48.321854Z","steps":["trace[1366013093] 'read index received' (duration: 105.786667ms)","trace[1366013093] 'applied index is now lower than readState.Index' (duration: 623.833µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:43:48.321981Z","caller":"traceutil/trace.go:171","msg":"trace[1270709712] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"116.312697ms","start":"2026-10-14T19:43:48.205616Z","end":"2026-10-14T19:43:48.321928Z","steps":["trace[1270709712] 'process raft request' (duration: 115.582841ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:43:48.322218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.758657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-14T19:43:48.322311Z","caller":"traceutil/trace.go:171","msg":"trace[407329711] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1318; }","duration":"106.909431ms","start":"2026-10-14T19:43:48.21538Z","end":"2026-10-14T19:43:48.32229Z","steps":["trace[407329711] 'agreement among raft nodes before linearized reading' (duration: 106.635595ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:43:56.555656Z","caller":"traceutil/trace.go:171","msg":"trace[1164933953] transaction","detail":"{read_only:false; response_revision:1445; number_of_response:1; }","duration":"162.182251ms","start":"2026-10-14T19:43:56.393439Z","end":"2026-10-14T19:43:56.555621Z","steps":["trace[1164933953] 'process raft request' (duration: 161.920446ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:43:56.580823Z","caller":"traceutil/trace.go:171","msg":"trace[953333092] transaction","detail":"{read_only:false; response_revision:1446; number_of_response:1; }","duration":"183.58783ms","start":"2026-10-14T19:43:56.397215Z","end":"2026-10-14T19:43:56.580803Z","steps":["trace[953333092] 'process raft request' (duration: 183.471787ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:43:56.581008Z","caller":"traceutil/trace.go:171","msg":"trace[911699057] linearizableReadLoop","detail":"{readStateIndex:1495; appliedIndex:1492; }","duration":"140.020806ms","start":"2026-10-14T19:43:56.440963Z","end":"2026-10-14T19:43:56.580984Z","steps":["trace[911699057] 'read index received' (duration: 114.440356ms)","trace[911699057] 'applied index is now lower than readState.Index' (duration: 25.57897ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:43:56.58107Z","caller":"traceutil/trace.go:171","msg":"trace[1296349943] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"152.442888ms","start":"2026-10-14T19:43:56.428608Z","end":"2026-10-14T19:43:56.581051Z","steps":["trace[1296349943] 'process raft request' (duration: 152.165052ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:43:56.581193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.21924ms","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-10-14T19:43:56.581227Z","caller":"traceutil/trace.go:171","msg":"trace[1344971255] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1447; }","duration":"140.315392ms","start":"2026-10-14T19:43:56.440902Z","end":"2026-10-14T19:43:56.581217Z","steps":["trace[1344971255] 'agreement among raft nodes before linearized reading' (duration: 140.167148ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:44:25.572954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.125985ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T19:44:25.573102Z","caller":"traceutil/trace.go:171","msg":"trace[1908797211] linearizableReadLoop","detail":"{readStateIndex:1960; appliedIndex:1959; }","duration":"445.980535ms","start":"2026-10-14T19:44:25.127099Z","end":"2026-10-14T19:44:25.57308Z","steps":["trace[1908797211] 'read index received' (duration: 88.822µs)","trace[1908797211] 'applied index is now lower than readState.Index' (duration: 445.889673ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:44:25.573244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.808034ms","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:5"} {"level":"info","ts":"2026-10-14T19:44:25.573272Z","caller":"traceutil/trace.go:171","msg":"trace[1080657672] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1883; }","duration":"172.888836ms","start":"2026-10-14T19:44:25.400372Z","end":"2026-10-14T19:44:25.573261Z","steps":["trace[1080657672] 'agreement among raft nodes before linearized reading' (duration: 172.823915ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:44:25.573275Z","caller":"traceutil/trace.go:171","msg":"trace[476890346] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"619.702429ms","start":"2026-10-14T19:44:24.953538Z","end":"2026-10-14T19:44:25.573241Z","steps":["trace[476890346] 'process raft request' (duration: 10.9713ms)","trace[476890346] 'compare' (duration: 607.906751ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:44:25.573454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:44:24.953515Z","time spent":"619.837882ms","remote":"127.0.0.1:35112","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-10-14T19:44:25.573567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.438155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-10-14T19:44:25.573666Z","caller":"traceutil/trace.go:171","msg":"trace[1497266400] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1883; }","duration":"446.613719ms","start":"2026-10-14T19:44:25.127028Z","end":"2026-10-14T19:44:25.573642Z","steps":["trace[1497266400] 'agreement among raft nodes before linearized reading' (duration: 446.17391ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:44:25.573685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.361663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6d73b406-3cc9-4b9b-b241-7e1448b9d7f6\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-10-14T19:44:25.573717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:44:25.127003Z","time spent":"446.703051ms","remote":"127.0.0.1:44710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-10-14T19:44:25.573726Z","caller":"traceutil/trace.go:171","msg":"trace[1870539860] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6d73b406-3cc9-4b9b-b241-7e1448b9d7f6; range_end:; response_count:1; response_revision:1883; }","duration":"103.452745ms","start":"2026-10-14T19:44:25.470262Z","end":"2026-10-14T19:44:25.573714Z","steps":["trace[1870539860] 'agreement among raft nodes before linearized reading' (duration: 103.279061ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:44:26.058071Z","caller":"traceutil/trace.go:171","msg":"trace[14029316] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"110.238213ms","start":"2026-10-14T19:44:25.947802Z","end":"2026-10-14T19:44:26.058041Z","steps":["trace[14029316] 'process raft request' (duration: 110.06819ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:44:33.091129Z","caller":"traceutil/trace.go:171","msg":"trace[1120864131] linearizableReadLoop","detail":"{readStateIndex:2032; appliedIndex:2031; }","duration":"110.903518ms","start":"2026-10-14T19:44:32.980198Z","end":"2026-10-14T19:44:33.091101Z","steps":["trace[1120864131] 'read index received' (duration: 110.734505ms)","trace[1120864131] 'applied index is now lower than readState.Index' (duration: 167.893µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:44:33.091183Z","caller":"traceutil/trace.go:171","msg":"trace[73727608] transaction","detail":"{read_only:false; response_revision:1954; number_of_response:1; }","duration":"113.447884ms","start":"2026-10-14T19:44:32.977704Z","end":"2026-10-14T19:44:33.091152Z","steps":["trace[73727608] 'process raft request' (duration: 113.196749ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:44:33.091344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.128083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-14T19:44:33.091385Z","caller":"traceutil/trace.go:171","msg":"trace[921683715] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1954; }","duration":"111.215115ms","start":"2026-10-14T19:44:32.980158Z","end":"2026-10-14T19:44:33.091373Z","steps":["trace[921683715] 'agreement among raft nodes before linearized reading' (duration: 111.051352ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:44:39.229781Z","caller":"traceutil/trace.go:171","msg":"trace[196370766] transaction","detail":"{read_only:false; response_revision:2003; number_of_response:1; }","duration":"107.027454ms","start":"2026-10-14T19:44:39.122731Z","end":"2026-10-14T19:44:39.229759Z","steps":["trace[196370766] 'process raft request' (duration: 106.643885ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:45:16.506789Z","caller":"traceutil/trace.go:171","msg":"trace[441323126] linearizableReadLoop","detail":"{readStateIndex:2295; appliedIndex:2294; }","duration":"143.976717ms","start":"2026-10-14T19:45:16.362783Z","end":"2026-10-14T19:45:16.506759Z","steps":["trace[441323126] 'read index received' (duration: 143.701141ms)","trace[441323126] 'applied index is now lower than readState.Index' (duration: 274.316µs)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:45:16.506966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.162671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T19:45:16.507018Z","caller":"traceutil/trace.go:171","msg":"trace[1773044492] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2207; }","duration":"144.274634ms","start":"2026-10-14T19:45:16.362726Z","end":"2026-10-14T19:45:16.507001Z","steps":["trace[1773044492] 'agreement among raft nodes before linearized reading' (duration: 144.171411ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:45:16.507055Z","caller":"traceutil/trace.go:171","msg":"trace[28480354] transaction","detail":"{read_only:false; response_revision:2207; number_of_response:1; }","duration":"219.603146ms","start":"2026-10-14T19:45:16.287429Z","end":"2026-10-14T19:45:16.507032Z","steps":["trace[28480354] 'process raft request' (duration: 219.173597ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:45:17.238328Z","caller":"traceutil/trace.go:171","msg":"trace[1269721388] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"180.558425ms","start":"2026-10-14T19:45:17.057748Z","end":"2026-10-14T19:45:17.238306Z","steps":["trace[1269721388] 'process raft request' (duration: 174.538862ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:45:17.23868Z","caller":"traceutil/trace.go:171","msg":"trace[1399829555] linearizableReadLoop","detail":"{readStateIndex:2298; appliedIndex:2296; }","duration":"174.117292ms","start":"2026-10-14T19:45:17.064533Z","end":"2026-10-14T19:45:17.23865Z","steps":["trace[1399829555] 'read index received' (duration: 167.801882ms)","trace[1399829555] 'applied index is now lower than readState.Index' (duration: 6.3145ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:45:17.23872Z","caller":"traceutil/trace.go:171","msg":"trace[930179282] transaction","detail":"{read_only:false; response_revision:2211; number_of_response:1; }","duration":"172.603639ms","start":"2026-10-14T19:45:17.066091Z","end":"2026-10-14T19:45:17.238694Z","steps":["trace[930179282] 'process raft request' (duration: 172.438465ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:45:17.238688Z","caller":"traceutil/trace.go:171","msg":"trace[530091137] transaction","detail":"{read_only:false; response_revision:2210; number_of_response:1; }","duration":"179.306957ms","start":"2026-10-14T19:45:17.059361Z","end":"2026-10-14T19:45:17.238668Z","steps":["trace[530091137] 'process raft request' (duration: 178.891718ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:45:17.238921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.364458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-14T19:45:17.238957Z","caller":"traceutil/trace.go:171","msg":"trace[729012839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2211; }","duration":"174.45901ms","start":"2026-10-14T19:45:17.064486Z","end":"2026-10-14T19:45:17.238945Z","steps":["trace[729012839] 'agreement among raft nodes before linearized reading' (duration: 174.267626ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:45:22.58955Z","caller":"traceutil/trace.go:171","msg":"trace[1574192320] transaction","detail":"{read_only:false; response_revision:2238; number_of_response:1; }","duration":"156.986194ms","start":"2026-10-14T19:45:22.432538Z","end":"2026-10-14T19:45:22.589524Z","steps":["trace[1574192320] 'process raft request' (duration: 156.686847ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:46:11.629751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.841506ms","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-10-14T19:46:11.629879Z","caller":"traceutil/trace.go:171","msg":"trace[1909437797] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2674; }","duration":"110.986169ms","start":"2026-10-14T19:46:11.518869Z","end":"2026-10-14T19:46:11.629855Z","steps":["trace[1909437797] 'range keys from in-memory index tree' (duration: 110.598359ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:46:11.997581Z","caller":"traceutil/trace.go:171","msg":"trace[963051848] linearizableReadLoop","detail":"{readStateIndex:2785; appliedIndex:2784; }","duration":"297.067404ms","start":"2026-10-14T19:46:11.700421Z","end":"2026-10-14T19:46:11.997489Z","steps":["trace[963051848] 'read index received' (duration: 275.932192ms)","trace[963051848] 'applied index is now lower than readState.Index' (duration: 21.133962ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:46:11.99759Z","caller":"traceutil/trace.go:171","msg":"trace[1068442516] transaction","detail":"{read_only:false; response_revision:2678; number_of_response:1; }","duration":"298.400614ms","start":"2026-10-14T19:46:11.699152Z","end":"2026-10-14T19:46:11.997553Z","steps":["trace[1068442516] 'process raft request' (duration: 277.216671ms)","trace[1068442516] 'compare' (duration: 20.990159ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:46:11.99784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.394811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-14T19:46:11.997929Z","caller":"traceutil/trace.go:171","msg":"trace[478398417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2678; }","duration":"297.511924ms","start":"2026-10-14T19:46:11.700398Z","end":"2026-10-14T19:46:11.99791Z","steps":["trace[478398417] 'agreement among raft nodes before linearized reading' (duration: 297.226498ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:46:11.997869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.098986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-10-14T19:46:11.99815Z","caller":"traceutil/trace.go:171","msg":"trace[1280811048] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2678; }","duration":"255.432774ms","start":"2026-10-14T19:46:11.742705Z","end":"2026-10-14T19:46:11.998137Z","steps":["trace[1280811048] 'agreement among raft nodes before linearized reading' (duration: 255.020275ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:46:44.501493Z","caller":"traceutil/trace.go:171","msg":"trace[336738227] transaction","detail":"{read_only:false; response_revision:2876; number_of_response:1; }","duration":"121.611365ms","start":"2026-10-14T19:46:44.379859Z","end":"2026-10-14T19:46:44.501471Z","steps":["trace[336738227] 'process raft request' (duration: 121.480592ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:46:45.066612Z","caller":"traceutil/trace.go:171","msg":"trace[1021165883] transaction","detail":"{read_only:false; response_revision:2877; number_of_response:1; }","duration":"141.709434ms","start":"2026-10-14T19:46:44.924798Z","end":"2026-10-14T19:46:45.066508Z","steps":["trace[1021165883] 'process raft request' (duration: 141.51869ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:46:50.531778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.970261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T19:46:50.531861Z","caller":"traceutil/trace.go:171","msg":"trace[1944856613] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:2908; }","duration":"232.118594ms","start":"2026-10-14T19:46:50.299722Z","end":"2026-10-14T19:46:50.531841Z","steps":["trace[1944856613] 'count revisions from in-memory index tree' (duration: 231.884038ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:46:51.199507Z","caller":"traceutil/trace.go:171","msg":"trace[1545087767] linearizableReadLoop","detail":"{readStateIndex:3024; appliedIndex:3023; }","duration":"105.331862ms","start":"2026-10-14T19:46:51.094149Z","end":"2026-10-14T19:46:51.199481Z","steps":["trace[1545087767] 'read index received' (duration: 105.133287ms)","trace[1545087767] 'applied index is now lower than readState.Index' (duration: 197.845µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:46:51.199774Z","caller":"traceutil/trace.go:171","msg":"trace[618261481] transaction","detail":"{read_only:false; response_revision:2909; number_of_response:1; }","duration":"109.127647ms","start":"2026-10-14T19:46:51.090621Z","end":"2026-10-14T19:46:51.199749Z","steps":["trace[618261481] 'process raft request' (duration: 108.708477ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:46:51.199868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.6778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T19:46:51.199914Z","caller":"traceutil/trace.go:171","msg":"trace[1317195092] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:2909; }","duration":"105.806692ms","start":"2026-10-14T19:46:51.094097Z","end":"2026-10-14T19:46:51.199903Z","steps":["trace[1317195092] 'agreement among raft nodes before linearized reading' (duration: 105.504495ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:49:59.091317Z","caller":"traceutil/trace.go:171","msg":"trace[1756274749] linearizableReadLoop","detail":"{readStateIndex:4256; appliedIndex:4255; }","duration":"290.157768ms","start":"2026-10-14T19:49:58.801136Z","end":"2026-10-14T19:49:59.091294Z","steps":["trace[1756274749] 'read index received' (duration: 290.090987ms)","trace[1756274749] 'applied index is now lower than readState.Index' (duration: 65.811µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:49:59.091353Z","caller":"traceutil/trace.go:171","msg":"trace[169397746] transaction","detail":"{read_only:false; response_revision:4096; number_of_response:1; }","duration":"297.081506ms","start":"2026-10-14T19:49:58.794248Z","end":"2026-10-14T19:49:59.091329Z","steps":["trace[169397746] 'process raft request' (duration: 296.917792ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:49:59.091585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.430933ms","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-10-14T19:49:59.091694Z","caller":"traceutil/trace.go:171","msg":"trace[172846458] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4096; }","duration":"290.597847ms","start":"2026-10-14T19:49:58.801078Z","end":"2026-10-14T19:49:59.091675Z","steps":["trace[172846458] 'agreement among raft nodes before linearized reading' (duration: 290.318291ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:49:59.092235Z","caller":"traceutil/trace.go:171","msg":"trace[1445011884] transaction","detail":"{read_only:false; response_revision:4097; number_of_response:1; }","duration":"175.670152ms","start":"2026-10-14T19:49:58.916556Z","end":"2026-10-14T19:49:59.092226Z","steps":["trace[1445011884] 'process raft request' (duration: 175.552139ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:49:59.09234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.403385ms","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-10-14T19:49:59.092391Z","caller":"traceutil/trace.go:171","msg":"trace[678610392] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4097; }","duration":"284.487766ms","start":"2026-10-14T19:49:58.807891Z","end":"2026-10-14T19:49:59.092379Z","steps":["trace[678610392] 'agreement among raft nodes before linearized reading' (duration: 284.311172ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:49:59.092414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.622085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-client-secret\" ","response":"range_response_count:1 size:692"} {"level":"info","ts":"2026-10-14T19:49:59.092464Z","caller":"traceutil/trace.go:171","msg":"trace[157144240] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-client-secret; range_end:; response_count:1; response_revision:4097; }","duration":"119.722198ms","start":"2026-10-14T19:49:58.972728Z","end":"2026-10-14T19:49:59.09245Z","steps":["trace[157144240] 'agreement among raft nodes before linearized reading' (duration: 119.558444ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:51:25.634738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.834977ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T19:51:25.634848Z","caller":"traceutil/trace.go:171","msg":"trace[1692416250] transaction","detail":"{read_only:false; response_revision:5171; number_of_response:1; }","duration":"222.308692ms","start":"2026-10-14T19:51:25.412521Z","end":"2026-10-14T19:51:25.63483Z","steps":["trace[1692416250] 'process raft request' (duration: 66.181269ms)","trace[1692416250] 'compare' (duration: 155.736074ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:51:25.646933Z","caller":"traceutil/trace.go:171","msg":"trace[487784533] linearizableReadLoop","detail":"{readStateIndex:5375; appliedIndex:5373; }","duration":"174.403789ms","start":"2026-10-14T19:51:25.472507Z","end":"2026-10-14T19:51:25.646911Z","steps":["trace[487784533] 'read index received' (duration: 6.173327ms)","trace[487784533] 'applied index is now lower than readState.Index' (duration: 168.229452ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:51:25.646984Z","caller":"traceutil/trace.go:171","msg":"trace[1763034641] transaction","detail":"{read_only:false; response_revision:5172; number_of_response:1; }","duration":"233.726775ms","start":"2026-10-14T19:51:25.413226Z","end":"2026-10-14T19:51:25.646952Z","steps":["trace[1763034641] 'process raft request' (duration: 233.578152ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:51:25.647138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.603833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T19:51:25.647212Z","caller":"traceutil/trace.go:171","msg":"trace[1484573324] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:5172; }","duration":"174.735226ms","start":"2026-10-14T19:51:25.472459Z","end":"2026-10-14T19:51:25.647194Z","steps":["trace[1484573324] 'agreement among raft nodes before linearized reading' (duration: 174.563362ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:51:25.649449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.092604ms","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-10-14T19:51:25.649524Z","caller":"traceutil/trace.go:171","msg":"trace[1731039160] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5174; }","duration":"138.213786ms","start":"2026-10-14T19:51:25.511292Z","end":"2026-10-14T19:51:25.649506Z","steps":["trace[1731039160] 'agreement among raft nodes before linearized reading' (duration: 137.96758ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:51:25.649818Z","caller":"traceutil/trace.go:171","msg":"trace[448620858] transaction","detail":"{read_only:false; response_revision:5173; number_of_response:1; }","duration":"157.615057ms","start":"2026-10-14T19:51:25.49218Z","end":"2026-10-14T19:51:25.649795Z","steps":["trace[448620858] 'process raft request' (duration: 156.83096ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:51:25.650013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.098372ms","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-10-14T19:51:25.650072Z","caller":"traceutil/trace.go:171","msg":"trace[665527605] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5174; }","duration":"119.193435ms","start":"2026-10-14T19:51:25.530862Z","end":"2026-10-14T19:51:25.650056Z","steps":["trace[665527605] 'agreement among raft nodes before linearized reading' (duration: 119.072662ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:51:25.650247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.176165ms","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-10-14T19:51:25.650291Z","caller":"traceutil/trace.go:171","msg":"trace[1744086797] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5174; }","duration":"124.271297ms","start":"2026-10-14T19:51:25.526009Z","end":"2026-10-14T19:51:25.65028Z","steps":["trace[1744086797] 'agreement among raft nodes before linearized reading' (duration: 124.127614ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:51:27.860171Z","caller":"traceutil/trace.go:171","msg":"trace[652722817] linearizableReadLoop","detail":"{readStateIndex:5495; appliedIndex:5494; }","duration":"217.006864ms","start":"2026-10-14T19:51:27.643144Z","end":"2026-10-14T19:51:27.860151Z","steps":["trace[652722817] 'read index received' (duration: 216.951023ms)","trace[652722817] 'applied index is now lower than readState.Index' (duration: 55.091µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:51:27.860265Z","caller":"traceutil/trace.go:171","msg":"trace[1711839102] transaction","detail":"{read_only:false; response_revision:5290; number_of_response:1; }","duration":"220.454781ms","start":"2026-10-14T19:51:27.639801Z","end":"2026-10-14T19:51:27.860256Z","steps":["trace[1711839102] 'process raft request' (duration: 220.225105ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:51:27.860544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.382632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7081797e-4bdf-459e-9f36-bda01471575a\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-10-14T19:51:27.860635Z","caller":"traceutil/trace.go:171","msg":"trace[245620024] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7081797e-4bdf-459e-9f36-bda01471575a; range_end:; response_count:1; response_revision:5290; }","duration":"217.505545ms","start":"2026-10-14T19:51:27.643095Z","end":"2026-10-14T19:51:27.8606Z","steps":["trace[245620024] 'agreement among raft nodes before linearized reading' (duration: 217.209109ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:51:27.875794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.951294ms","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-10-14T19:51:27.875851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.11637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.66\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-10-14T19:51:27.875906Z","caller":"traceutil/trace.go:171","msg":"trace[1726397628] transaction","detail":"{read_only:false; response_revision:5291; number_of_response:1; }","duration":"197.01702ms","start":"2026-10-14T19:51:27.678881Z","end":"2026-10-14T19:51:27.875898Z","steps":["trace[1726397628] 'process raft request' (duration: 196.625522ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:51:27.875907Z","caller":"traceutil/trace.go:171","msg":"trace[71755207] range","detail":"{range_begin:/registry/masterleases/199.204.45.66; range_end:; response_count:1; response_revision:5291; }","duration":"196.181551ms","start":"2026-10-14T19:51:27.679711Z","end":"2026-10-14T19:51:27.875892Z","steps":["trace[71755207] 'agreement among raft nodes before linearized reading' (duration: 196.016658ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:51:27.875922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.405785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-10-14T19:51:27.875953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.586201ms","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-10-14T19:51:27.876005Z","caller":"traceutil/trace.go:171","msg":"trace[335608227] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5291; }","duration":"210.662693ms","start":"2026-10-14T19:51:27.665329Z","end":"2026-10-14T19:51:27.875992Z","steps":["trace[335608227] 'agreement among raft nodes before linearized reading' (duration: 210.49901ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:51:27.875976Z","caller":"traceutil/trace.go:171","msg":"trace[1501680739] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5291; }","duration":"209.488687ms","start":"2026-10-14T19:51:27.666475Z","end":"2026-10-14T19:51:27.875964Z","steps":["trace[1501680739] 'agreement among raft nodes before linearized reading' (duration: 209.332113ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:51:27.875865Z","caller":"traceutil/trace.go:171","msg":"trace[1781868903] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5291; }","duration":"213.056316ms","start":"2026-10-14T19:51:27.662792Z","end":"2026-10-14T19:51:27.875849Z","steps":["trace[1781868903] 'agreement among raft nodes before linearized reading' (duration: 212.860682ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:51:27.87613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.975206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-10-14T19:51:27.876099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.440745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T19:51:27.876207Z","caller":"traceutil/trace.go:171","msg":"trace[828614521] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5291; }","duration":"209.068458ms","start":"2026-10-14T19:51:27.667118Z","end":"2026-10-14T19:51:27.876187Z","steps":["trace[828614521] 'agreement among raft nodes before linearized reading' (duration: 208.790602ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:51:27.876251Z","caller":"traceutil/trace.go:171","msg":"trace[1641841203] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5291; }","duration":"190.629399ms","start":"2026-10-14T19:51:27.685591Z","end":"2026-10-14T19:51:27.87622Z","steps":["trace[1641841203] 'agreement among raft nodes before linearized reading' (duration: 190.398533ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:51:27.876442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.710862ms","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-10-14T19:51:27.876656Z","caller":"traceutil/trace.go:171","msg":"trace[330552023] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5291; }","duration":"209.967818ms","start":"2026-10-14T19:51:27.666676Z","end":"2026-10-14T19:51:27.876644Z","steps":["trace[330552023] 'agreement among raft nodes before linearized reading' (duration: 209.092279ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:51:30.086641Z","caller":"traceutil/trace.go:171","msg":"trace[1252137685] linearizableReadLoop","detail":"{readStateIndex:5533; appliedIndex:5532; }","duration":"190.6626ms","start":"2026-10-14T19:51:29.895904Z","end":"2026-10-14T19:51:30.086566Z","steps":["trace[1252137685] 'read index received' (duration: 147.268297ms)","trace[1252137685] 'applied index is now lower than readState.Index' (duration: 43.392713ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:51:30.086681Z","caller":"traceutil/trace.go:171","msg":"trace[402207386] transaction","detail":"{read_only:false; response_revision:5326; number_of_response:1; }","duration":"220.89352ms","start":"2026-10-14T19:51:29.865744Z","end":"2026-10-14T19:51:30.086638Z","steps":["trace[402207386] 'process raft request' (duration: 177.485657ms)","trace[402207386] 'compare' (duration: 43.164738ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:51:30.086894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.916095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-14T19:51:30.086933Z","caller":"traceutil/trace.go:171","msg":"trace[1166878996] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5326; }","duration":"190.983087ms","start":"2026-10-14T19:51:29.89594Z","end":"2026-10-14T19:51:30.086923Z","steps":["trace[1166878996] 'agreement among raft nodes before linearized reading' (duration: 190.813773ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:51:30.086976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.609558ms","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-10-14T19:51:30.086976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.992286ms","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-10-14T19:51:30.08703Z","caller":"traceutil/trace.go:171","msg":"trace[1206245535] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5326; }","duration":"190.68213ms","start":"2026-10-14T19:51:29.896332Z","end":"2026-10-14T19:51:30.087015Z","steps":["trace[1206245535] 'agreement among raft nodes before linearized reading' (duration: 190.541406ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:51:30.087096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.170401ms","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-10-14T19:51:30.087169Z","caller":"traceutil/trace.go:171","msg":"trace[683120676] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5326; }","duration":"191.287544ms","start":"2026-10-14T19:51:29.895864Z","end":"2026-10-14T19:51:30.087152Z","steps":["trace[683120676] 'agreement among raft nodes before linearized reading' (duration: 190.870994ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:51:30.087031Z","caller":"traceutil/trace.go:171","msg":"trace[959087109] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5326; }","duration":"191.078639ms","start":"2026-10-14T19:51:29.895941Z","end":"2026-10-14T19:51:30.08702Z","steps":["trace[959087109] 'agreement among raft nodes before linearized reading' (duration: 190.937546ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:51:30.086975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.427324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-14T19:51:30.087307Z","caller":"traceutil/trace.go:171","msg":"trace[1534268053] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5326; }","duration":"190.769312ms","start":"2026-10-14T19:51:29.896526Z","end":"2026-10-14T19:51:30.087295Z","steps":["trace[1534268053] 'agreement among raft nodes before linearized reading' (duration: 190.332652ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:51:30.213095Z","caller":"traceutil/trace.go:171","msg":"trace[736291269] transaction","detail":"{read_only:false; response_revision:5328; number_of_response:1; }","duration":"121.521476ms","start":"2026-10-14T19:51:30.09155Z","end":"2026-10-14T19:51:30.213071Z","steps":["trace[736291269] 'process raft request' (duration: 121.310511ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:51:30.213146Z","caller":"traceutil/trace.go:171","msg":"trace[192974732] transaction","detail":"{read_only:false; response_revision:5330; number_of_response:1; }","duration":"120.577434ms","start":"2026-10-14T19:51:30.092561Z","end":"2026-10-14T19:51:30.213138Z","steps":["trace[192974732] 'process raft request' (duration: 120.470272ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:51:30.213148Z","caller":"traceutil/trace.go:171","msg":"trace[1143581727] transaction","detail":"{read_only:false; response_revision:5329; number_of_response:1; }","duration":"121.549646ms","start":"2026-10-14T19:51:30.091579Z","end":"2026-10-14T19:51:30.213128Z","steps":["trace[1143581727] 'process raft request' (duration: 121.414213ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:51:30.213108Z","caller":"traceutil/trace.go:171","msg":"trace[1395045573] transaction","detail":"{read_only:false; response_revision:5331; number_of_response:1; }","duration":"120.143135ms","start":"2026-10-14T19:51:30.092949Z","end":"2026-10-14T19:51:30.213092Z","steps":["trace[1395045573] 'process raft request' (duration: 120.108495ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:51:42.866355Z","caller":"traceutil/trace.go:171","msg":"trace[2055701331] transaction","detail":"{read_only:false; response_revision:5564; number_of_response:1; }","duration":"119.467379ms","start":"2026-10-14T19:51:42.746844Z","end":"2026-10-14T19:51:42.866311Z","steps":["trace[2055701331] 'process raft request' (duration: 58.084708ms)","trace[2055701331] 'compare' (duration: 61.128466ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:51:51.33709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.368586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-909a216a-be90-4466-a1bc-ecb8e1b1613c\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-10-14T19:51:51.337176Z","caller":"traceutil/trace.go:171","msg":"trace[2035036732] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-909a216a-be90-4466-a1bc-ecb8e1b1613c; range_end:; response_count:1; response_revision:5734; }","duration":"104.501488ms","start":"2026-10-14T19:51:51.232654Z","end":"2026-10-14T19:51:51.337155Z","steps":["trace[2035036732] 'range keys from in-memory index tree' (duration: 104.192282ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:51:52.187092Z","caller":"traceutil/trace.go:171","msg":"trace[1468869364] linearizableReadLoop","detail":"{readStateIndex:5954; appliedIndex:5953; }","duration":"203.649278ms","start":"2026-10-14T19:51:51.983412Z","end":"2026-10-14T19:51:52.187062Z","steps":["trace[1468869364] 'read index received' (duration: 203.438193ms)","trace[1468869364] 'applied index is now lower than readState.Index' (duration: 209.365µs)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:51:52.187324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.894113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-10-14T19:51:52.187443Z","caller":"traceutil/trace.go:171","msg":"trace[241719202] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5735; }","duration":"204.079047ms","start":"2026-10-14T19:51:51.983348Z","end":"2026-10-14T19:51:52.187427Z","steps":["trace[241719202] 'agreement among raft nodes before linearized reading' (duration: 203.819121ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:51:52.187477Z","caller":"traceutil/trace.go:171","msg":"trace[1090515758] transaction","detail":"{read_only:false; response_revision:5735; number_of_response:1; }","duration":"280.281527ms","start":"2026-10-14T19:51:51.907161Z","end":"2026-10-14T19:51:52.187443Z","steps":["trace[1090515758] 'process raft request' (duration: 279.712295ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:51:54.360551Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2932} {"level":"info","ts":"2026-10-14T19:51:54.44039Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2932,"took":"78.169764ms","hash":1460059914,"current-db-size-bytes":56213504,"current-db-size":"56 MB","current-db-size-in-use-bytes":31956992,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-14T19:51:54.440474Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1460059914,"revision":2932,"compact-revision":-1} {"level":"info","ts":"2026-10-14T19:52:04.354372Z","caller":"traceutil/trace.go:171","msg":"trace[897939988] transaction","detail":"{read_only:false; response_revision:5894; number_of_response:1; }","duration":"201.424998ms","start":"2026-10-14T19:52:04.152915Z","end":"2026-10-14T19:52:04.35434Z","steps":["trace[897939988] 'process raft request' (duration: 138.978212ms)","trace[897939988] 'compare' (duration: 62.248702ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:52:04.354379Z","caller":"traceutil/trace.go:171","msg":"trace[926762593] transaction","detail":"{read_only:false; response_revision:5895; number_of_response:1; }","duration":"200.468056ms","start":"2026-10-14T19:52:04.153888Z","end":"2026-10-14T19:52:04.354356Z","steps":["trace[926762593] 'process raft request' (duration: 200.375784ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:52:04.354827Z","caller":"traceutil/trace.go:171","msg":"trace[794619015] linearizableReadLoop","detail":"{readStateIndex:6118; appliedIndex:6116; }","duration":"201.809256ms","start":"2026-10-14T19:52:04.152991Z","end":"2026-10-14T19:52:04.3548Z","steps":["trace[794619015] 'read index received' (duration: 29.964085ms)","trace[794619015] 'applied index is now lower than readState.Index' (duration: 171.843321ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:52:04.354845Z","caller":"traceutil/trace.go:171","msg":"trace[1176132608] transaction","detail":"{read_only:false; response_revision:5896; number_of_response:1; }","duration":"199.878184ms","start":"2026-10-14T19:52:04.154943Z","end":"2026-10-14T19:52:04.354822Z","steps":["trace[1176132608] 'process raft request' (duration: 199.360282ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:52:04.354968Z","caller":"traceutil/trace.go:171","msg":"trace[1849737087] transaction","detail":"{read_only:false; response_revision:5897; number_of_response:1; }","duration":"118.123451ms","start":"2026-10-14T19:52:04.236787Z","end":"2026-10-14T19:52:04.35491Z","steps":["trace[1849737087] 'process raft request' (duration: 117.756512ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:52:04.355077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.585985ms","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-10-14T19:52:04.355139Z","caller":"traceutil/trace.go:171","msg":"trace[1964557039] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5897; }","duration":"152.695006ms","start":"2026-10-14T19:52:04.202427Z","end":"2026-10-14T19:52:04.355122Z","steps":["trace[1964557039] 'agreement among raft nodes before linearized reading' (duration: 152.589254ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:52:04.355086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.074372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-909a216a-be90-4466-a1bc-ecb8e1b1613c\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-10-14T19:52:04.355345Z","caller":"traceutil/trace.go:171","msg":"trace[1615498569] range","detail":"{range_begin:/registry/persistentvolumes/pvc-909a216a-be90-4466-a1bc-ecb8e1b1613c; range_end:; response_count:1; response_revision:5897; }","duration":"202.386409ms","start":"2026-10-14T19:52:04.152945Z","end":"2026-10-14T19:52:04.355332Z","steps":["trace[1615498569] 'agreement among raft nodes before linearized reading' (duration: 201.98945ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:56:54.369671Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5785} {"level":"info","ts":"2026-10-14T19:56:54.469752Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5785,"took":"97.291485ms","hash":4070080904,"current-db-size-bytes":56213504,"current-db-size":"56 MB","current-db-size-in-use-bytes":26701824,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-14T19:56:54.46983Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4070080904,"revision":5785,"compact-revision":2932} {"level":"warn","ts":"2026-10-14T19:58:14.972675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.151687ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T19:58:14.972844Z","caller":"traceutil/trace.go:171","msg":"trace[253124982] linearizableReadLoop","detail":"{readStateIndex:8974; appliedIndex:8972; }","duration":"283.630892ms","start":"2026-10-14T19:58:14.689196Z","end":"2026-10-14T19:58:14.972827Z","steps":["trace[253124982] 'read index received' (duration: 54.402µs)","trace[253124982] 'applied index is now lower than readState.Index' (duration: 283.5754ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:58:14.972931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.743925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T19:58:14.97296Z","caller":"traceutil/trace.go:171","msg":"trace[1932660510] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8661; }","duration":"283.820646ms","start":"2026-10-14T19:58:14.68913Z","end":"2026-10-14T19:58:14.972951Z","steps":["trace[1932660510] 'agreement among raft nodes before linearized reading' (duration: 283.746565ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:58:14.973158Z","caller":"traceutil/trace.go:171","msg":"trace[977665458] transaction","detail":"{read_only:false; response_revision:8661; number_of_response:1; }","duration":"443.422541ms","start":"2026-10-14T19:58:14.529721Z","end":"2026-10-14T19:58:14.973144Z","steps":["trace[977665458] 'process raft request' (duration: 443.055153ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:58:14.973164Z","caller":"traceutil/trace.go:171","msg":"trace[292739340] transaction","detail":"{read_only:false; response_revision:8660; number_of_response:1; }","duration":"445.913466ms","start":"2026-10-14T19:58:14.527215Z","end":"2026-10-14T19:58:14.973129Z","steps":["trace[292739340] 'compare' (duration: 444.050175ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:58:14.973216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:58:14.529705Z","time spent":"443.479472ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T19:58:14.973369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:58:14.5272Z","time spent":"446.06958ms","remote":"127.0.0.1:35112","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-10-14T19:58:26.414188Z","caller":"traceutil/trace.go:171","msg":"trace[509601440] transaction","detail":"{read_only:false; response_revision:8717; number_of_response:1; }","duration":"193.316232ms","start":"2026-10-14T19:58:26.220833Z","end":"2026-10-14T19:58:26.41415Z","steps":["trace[509601440] 'process raft request' (duration: 193.031695ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:58:26.603566Z","caller":"traceutil/trace.go:171","msg":"trace[1199275016] transaction","detail":"{read_only:false; response_revision:8719; number_of_response:1; }","duration":"111.901248ms","start":"2026-10-14T19:58:26.491627Z","end":"2026-10-14T19:58:26.603529Z","steps":["trace[1199275016] 'process raft request' (duration: 111.769125ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:58:26.603613Z","caller":"traceutil/trace.go:171","msg":"trace[1616391636] transaction","detail":"{read_only:false; response_revision:8718; number_of_response:1; }","duration":"126.047382ms","start":"2026-10-14T19:58:26.477521Z","end":"2026-10-14T19:58:26.603568Z","steps":["trace[1616391636] 'process raft request' (duration: 96.851895ms)","trace[1616391636] 'compare' (duration: 28.796698ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:58:27.446511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.031308ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T19:58:27.446673Z","caller":"traceutil/trace.go:171","msg":"trace[1800836471] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:8722; }","duration":"213.208732ms","start":"2026-10-14T19:58:27.233443Z","end":"2026-10-14T19:58:27.446652Z","steps":["trace[1800836471] 'range keys from in-memory index tree' (duration: 213.014778ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:58:27.446925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.088167ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T19:58:27.447156Z","caller":"traceutil/trace.go:171","msg":"trace[673589765] transaction","detail":"{read_only:false; response_revision:8723; number_of_response:1; }","duration":"402.183317ms","start":"2026-10-14T19:58:27.044955Z","end":"2026-10-14T19:58:27.447138Z","steps":["trace[673589765] 'process raft request' (duration: 161.737781ms)","trace[673589765] 'compare' (duration: 239.932724ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:58:27.447189Z","caller":"traceutil/trace.go:171","msg":"trace[381166315] transaction","detail":"{read_only:false; response_revision:8724; number_of_response:1; }","duration":"248.740028ms","start":"2026-10-14T19:58:27.198418Z","end":"2026-10-14T19:58:27.447158Z","steps":["trace[381166315] 'process raft request' (duration: 248.660386ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:58:27.447306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:58:27.044933Z","time spent":"402.267679ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T19:58:28.811604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.412876ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T19:58:28.811933Z","caller":"traceutil/trace.go:171","msg":"trace[515744685] transaction","detail":"{read_only:false; response_revision:8730; number_of_response:1; }","duration":"203.247782ms","start":"2026-10-14T19:58:28.608661Z","end":"2026-10-14T19:58:28.811909Z","steps":["trace[515744685] 'process raft request' (duration: 203.110029ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:58:28.812157Z","caller":"traceutil/trace.go:171","msg":"trace[238978993] transaction","detail":"{read_only:false; response_revision:8729; number_of_response:1; }","duration":"392.020312ms","start":"2026-10-14T19:58:28.420092Z","end":"2026-10-14T19:58:28.812112Z","steps":["trace[238978993] 'process raft request' (duration: 168.952472ms)","trace[238978993] 'compare' (duration: 222.1286ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:58:28.812376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:58:28.420064Z","time spent":"392.190967ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T19:58:28.812345Z","caller":"traceutil/trace.go:171","msg":"trace[1542531559] linearizableReadLoop","detail":"{readStateIndex:9045; appliedIndex:9044; }","duration":"204.176593ms","start":"2026-10-14T19:58:28.608126Z","end":"2026-10-14T19:58:28.812303Z","steps":["trace[1542531559] 'read index received' (duration: 40.141µs)","trace[1542531559] 'applied index is now lower than readState.Index' (duration: 204.131122ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:58:28.812591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.623796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-14T19:58:28.812663Z","caller":"traceutil/trace.go:171","msg":"trace[1036109539] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8730; }","duration":"192.743299ms","start":"2026-10-14T19:58:28.619901Z","end":"2026-10-14T19:58:28.812645Z","steps":["trace[1036109539] 'agreement among raft nodes before linearized reading' (duration: 192.618596ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:58:28.812566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.413938ms","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-10-14T19:58:28.812703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.909513ms","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-10-14T19:58:28.812735Z","caller":"traceutil/trace.go:171","msg":"trace[933357182] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8730; }","duration":"204.650483ms","start":"2026-10-14T19:58:28.608068Z","end":"2026-10-14T19:58:28.812719Z","steps":["trace[933357182] 'agreement among raft nodes before linearized reading' (duration: 204.347746ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:58:28.812773Z","caller":"traceutil/trace.go:171","msg":"trace[1121830115] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8730; }","duration":"184.019386ms","start":"2026-10-14T19:58:28.628736Z","end":"2026-10-14T19:58:28.812755Z","steps":["trace[1121830115] 'agreement among raft nodes before linearized reading' (duration: 183.846962ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:58:28.812916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.363745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T19:58:28.812964Z","caller":"traceutil/trace.go:171","msg":"trace[17767549] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8730; }","duration":"124.430546ms","start":"2026-10-14T19:58:28.688522Z","end":"2026-10-14T19:58:28.812953Z","steps":["trace[17767549] 'agreement among raft nodes before linearized reading' (duration: 124.016637ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:58:29.011165Z","caller":"traceutil/trace.go:171","msg":"trace[2060608728] linearizableReadLoop","detail":"{readStateIndex:9049; appliedIndex:9047; }","duration":"130.626744ms","start":"2026-10-14T19:58:28.880512Z","end":"2026-10-14T19:58:29.011139Z","steps":["trace[2060608728] 'read index received' (duration: 130.390748ms)","trace[2060608728] 'applied index is now lower than readState.Index' (duration: 234.846µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:58:29.011245Z","caller":"traceutil/trace.go:171","msg":"trace[1263526665] transaction","detail":"{read_only:false; response_revision:8732; number_of_response:1; }","duration":"193.872234ms","start":"2026-10-14T19:58:28.817296Z","end":"2026-10-14T19:58:29.011168Z","steps":["trace[1263526665] 'process raft request' (duration: 193.643379ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:58:29.011322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.796397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T19:58:29.011341Z","caller":"traceutil/trace.go:171","msg":"trace[1405521211] transaction","detail":"{read_only:false; response_revision:8733; number_of_response:1; }","duration":"193.875654ms","start":"2026-10-14T19:58:28.817432Z","end":"2026-10-14T19:58:29.011307Z","steps":["trace[1405521211] 'process raft request' (duration: 193.65927ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:58:29.011854Z","caller":"traceutil/trace.go:171","msg":"trace[809824599] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:8733; }","duration":"130.95729ms","start":"2026-10-14T19:58:28.880446Z","end":"2026-10-14T19:58:29.011403Z","steps":["trace[809824599] 'agreement among raft nodes before linearized reading' (duration: 130.808537ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:58:54.837271Z","caller":"traceutil/trace.go:171","msg":"trace[1401735062] transaction","detail":"{read_only:false; response_revision:8921; number_of_response:1; }","duration":"101.37197ms","start":"2026-10-14T19:58:54.735869Z","end":"2026-10-14T19:58:54.837241Z","steps":["trace[1401735062] 'process raft request' (duration: 101.167446ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:58:58.827157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.62987ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T19:58:58.827285Z","caller":"traceutil/trace.go:171","msg":"trace[870630437] linearizableReadLoop","detail":"{readStateIndex:9268; appliedIndex:9267; }","duration":"139.50422ms","start":"2026-10-14T19:58:58.687763Z","end":"2026-10-14T19:58:58.827267Z","steps":["trace[870630437] 'read index received' (duration: 52.641µs)","trace[870630437] 'applied index is now lower than readState.Index' (duration: 139.450119ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:58:58.827386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.635392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T19:58:58.82741Z","caller":"traceutil/trace.go:171","msg":"trace[1937762141] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8943; }","duration":"139.737585ms","start":"2026-10-14T19:58:58.687664Z","end":"2026-10-14T19:58:58.827401Z","steps":["trace[1937762141] 'agreement among raft nodes before linearized reading' (duration: 139.689734ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:58:58.827378Z","caller":"traceutil/trace.go:171","msg":"trace[339371161] transaction","detail":"{read_only:false; response_revision:8943; number_of_response:1; }","duration":"665.647357ms","start":"2026-10-14T19:58:58.161698Z","end":"2026-10-14T19:58:58.827345Z","steps":["trace[339371161] 'process raft request' (duration: 436.739521ms)","trace[339371161] 'compare' (duration: 228.518978ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:58:58.827542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:58:58.161674Z","time spent":"665.77961ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T19:59:00.957553Z","caller":"traceutil/trace.go:171","msg":"trace[1910516104] transaction","detail":"{read_only:false; response_revision:8955; number_of_response:1; }","duration":"222.022435ms","start":"2026-10-14T19:59:00.735502Z","end":"2026-10-14T19:59:00.957525Z","steps":["trace[1910516104] 'process raft request' (duration: 221.851142ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:59:01.06996Z","caller":"traceutil/trace.go:171","msg":"trace[592310621] transaction","detail":"{read_only:false; response_revision:8956; number_of_response:1; }","duration":"134.792546ms","start":"2026-10-14T19:59:00.935135Z","end":"2026-10-14T19:59:01.069928Z","steps":["trace[592310621] 'process raft request' (duration: 104.263404ms)","trace[592310621] 'compare' (duration: 30.354788ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:59:08.213325Z","caller":"traceutil/trace.go:171","msg":"trace[1180054876] transaction","detail":"{read_only:false; response_revision:8995; number_of_response:1; }","duration":"107.138668ms","start":"2026-10-14T19:59:08.10616Z","end":"2026-10-14T19:59:08.213299Z","steps":["trace[1180054876] 'process raft request' (duration: 106.943414ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:59:08.257542Z","caller":"traceutil/trace.go:171","msg":"trace[528305792] transaction","detail":"{read_only:false; response_revision:8996; number_of_response:1; }","duration":"109.439228ms","start":"2026-10-14T19:59:08.148061Z","end":"2026-10-14T19:59:08.2575Z","steps":["trace[528305792] 'process raft request' (duration: 109.142902ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:59:09.119418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.605802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-10-14T19:59:09.11954Z","caller":"traceutil/trace.go:171","msg":"trace[1000174277] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8998; }","duration":"139.770295ms","start":"2026-10-14T19:59:08.979744Z","end":"2026-10-14T19:59:09.119515Z","steps":["trace[1000174277] 'range keys from in-memory index tree' (duration: 139.389277ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T19:59:12.693515Z","caller":"traceutil/trace.go:171","msg":"trace[2054860106] transaction","detail":"{read_only:false; response_revision:9031; number_of_response:1; }","duration":"320.671156ms","start":"2026-10-14T19:59:12.372809Z","end":"2026-10-14T19:59:12.693481Z","steps":["trace[2054860106] 'process raft request' (duration: 241.075794ms)","trace[2054860106] 'compare' (duration: 79.186573ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T19:59:12.69364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.516595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T19:59:12.693503Z","caller":"traceutil/trace.go:171","msg":"trace[1861258433] linearizableReadLoop","detail":"{readStateIndex:9358; appliedIndex:9356; }","duration":"311.357921ms","start":"2026-10-14T19:59:12.382103Z","end":"2026-10-14T19:59:12.693461Z","steps":["trace[1861258433] 'read index received' (duration: 2.401423ms)","trace[1861258433] 'applied index is now lower than readState.Index' (duration: 308.954998ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T19:59:12.693677Z","caller":"traceutil/trace.go:171","msg":"trace[134610794] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:9031; }","duration":"311.584206ms","start":"2026-10-14T19:59:12.382083Z","end":"2026-10-14T19:59:12.693667Z","steps":["trace[134610794] 'agreement among raft nodes before linearized reading' (duration: 311.479113ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T19:59:12.693698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:59:12.372802Z","time spent":"320.786389ms","remote":"127.0.0.1:35020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4634,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T19:59:12.693716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T19:59:12.382076Z","time spent":"311.631708ms","remote":"127.0.0.1:34964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"info","ts":"2026-10-14T19:59:23.877229Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000250e.wal"} {"level":"info","ts":"2026-10-14T20:00:11.628785Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1e882206af630b31","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-14T20:00:11.637613Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-14T20:00:11.637719Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-14T20:00:34.676151Z","caller":"traceutil/trace.go:171","msg":"trace[2085739173] transaction","detail":"{read_only:false; response_revision:9840; number_of_response:1; }","duration":"158.851845ms","start":"2026-10-14T20:00:34.517276Z","end":"2026-10-14T20:00:34.676128Z","steps":["trace[2085739173] 'process raft request' (duration: 158.661011ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:00:35.008888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.858933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T20:00:35.008991Z","caller":"traceutil/trace.go:171","msg":"trace[696793485] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:9841; }","duration":"158.028077ms","start":"2026-10-14T20:00:34.85094Z","end":"2026-10-14T20:00:35.008968Z","steps":["trace[696793485] 'count revisions from in-memory index tree' (duration: 157.727491ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:01:54.377752Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8007} {"level":"info","ts":"2026-10-14T20:01:54.449924Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8007,"took":"69.912027ms","hash":3289659463,"current-db-size-bytes":56213504,"current-db-size":"56 MB","current-db-size-in-use-bytes":27893760,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-14T20:01:54.450005Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3289659463,"revision":8007,"compact-revision":5785} {"level":"info","ts":"2026-10-14T20:05:54.193686Z","caller":"traceutil/trace.go:171","msg":"trace[42154514] transaction","detail":"{read_only:false; response_revision:12161; number_of_response:1; }","duration":"320.444267ms","start":"2026-10-14T20:05:53.873217Z","end":"2026-10-14T20:05:54.193661Z","steps":["trace[42154514] 'process raft request' (duration: 319.149278ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:05:54.193842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:05:53.873185Z","time spent":"320.57364ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T20:05:54.193664Z","caller":"traceutil/trace.go:171","msg":"trace[449374813] linearizableReadLoop","detail":"{readStateIndex:12588; appliedIndex:12586; }","duration":"314.083776ms","start":"2026-10-14T20:05:53.879546Z","end":"2026-10-14T20:05:54.19363Z","steps":["trace[449374813] 'read index received' (duration: 71.946181ms)","trace[449374813] 'applied index is now lower than readState.Index' (duration: 242.135925ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T20:05:54.194173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.615039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-14T20:05:54.194359Z","caller":"traceutil/trace.go:171","msg":"trace[438534489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12161; }","duration":"314.858544ms","start":"2026-10-14T20:05:53.87948Z","end":"2026-10-14T20:05:54.194339Z","steps":["trace[438534489] 'agreement among raft nodes before linearized reading' (duration: 314.258891ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:05:54.194518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:05:53.879458Z","time spent":"315.040408ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-14T20:06:16.658433Z","caller":"traceutil/trace.go:171","msg":"trace[1677293614] linearizableReadLoop","detail":"{readStateIndex:12716; appliedIndex:12715; }","duration":"214.424763ms","start":"2026-10-14T20:06:16.443984Z","end":"2026-10-14T20:06:16.658408Z","steps":["trace[1677293614] 'read index received' (duration: 214.254419ms)","trace[1677293614] 'applied index is now lower than readState.Index' (duration: 168.464µs)"],"step_count":2} {"level":"warn","ts":"2026-10-14T20:06:16.658799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.750159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T20:06:16.65891Z","caller":"traceutil/trace.go:171","msg":"trace[1108748174] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:12285; }","duration":"214.962744ms","start":"2026-10-14T20:06:16.443886Z","end":"2026-10-14T20:06:16.658849Z","steps":["trace[1108748174] 'agreement among raft nodes before linearized reading' (duration: 214.77898ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:06:16.658678Z","caller":"traceutil/trace.go:171","msg":"trace[1341777594] transaction","detail":"{read_only:false; response_revision:12285; number_of_response:1; }","duration":"225.881206ms","start":"2026-10-14T20:06:16.432593Z","end":"2026-10-14T20:06:16.658474Z","steps":["trace[1341777594] 'process raft request' (duration: 225.656901ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:06:17.741863Z","caller":"traceutil/trace.go:171","msg":"trace[430817451] transaction","detail":"{read_only:false; response_revision:12290; number_of_response:1; }","duration":"137.530082ms","start":"2026-10-14T20:06:17.604261Z","end":"2026-10-14T20:06:17.741791Z","steps":["trace[430817451] 'process raft request' (duration: 97.21028ms)","trace[430817451] 'compare' (duration: 40.123448ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T20:06:54.386085Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10389} {"level":"info","ts":"2026-10-14T20:06:54.468064Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10389,"took":"79.725203ms","hash":442140167,"current-db-size-bytes":56213504,"current-db-size":"56 MB","current-db-size-in-use-bytes":24825856,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-10-14T20:06:54.468132Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":442140167,"revision":10389,"compact-revision":8007} {"level":"info","ts":"2026-10-14T20:11:54.393408Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12542} {"level":"info","ts":"2026-10-14T20:11:54.473284Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12542,"took":"77.581966ms","hash":376525055,"current-db-size-bytes":56213504,"current-db-size":"56 MB","current-db-size-in-use-bytes":27697152,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-14T20:11:54.473357Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":376525055,"revision":12542,"compact-revision":10389} {"level":"info","ts":"2026-10-14T20:12:13.713067Z","caller":"traceutil/trace.go:171","msg":"trace[411466269] linearizableReadLoop","detail":"{readStateIndex:15231; appliedIndex:15230; }","duration":"103.062859ms","start":"2026-10-14T20:12:13.609986Z","end":"2026-10-14T20:12:13.713049Z","steps":["trace[411466269] 'read index received' (duration: 102.937706ms)","trace[411466269] 'applied index is now lower than readState.Index' (duration: 124.353µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T20:12:13.713325Z","caller":"traceutil/trace.go:171","msg":"trace[468899288] transaction","detail":"{read_only:false; response_revision:14714; number_of_response:1; }","duration":"132.172623ms","start":"2026-10-14T20:12:13.581136Z","end":"2026-10-14T20:12:13.713308Z","steps":["trace[468899288] 'process raft request' (duration: 131.801595ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:12:13.713543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.541349ms","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-10-14T20:12:13.713583Z","caller":"traceutil/trace.go:171","msg":"trace[235911917] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14714; }","duration":"103.610592ms","start":"2026-10-14T20:12:13.609962Z","end":"2026-10-14T20:12:13.713573Z","steps":["trace[235911917] 'agreement among raft nodes before linearized reading' (duration: 103.498419ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:12:53.824053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.025656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-14T20:12:53.824147Z","caller":"traceutil/trace.go:171","msg":"trace[1882189083] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14934; }","duration":"173.161359ms","start":"2026-10-14T20:12:53.650965Z","end":"2026-10-14T20:12:53.824126Z","steps":["trace[1882189083] 'range keys from in-memory index tree' (duration: 172.799291ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:12:53.824178Z","caller":"traceutil/trace.go:171","msg":"trace[1638366457] linearizableReadLoop","detail":"{readStateIndex:15461; appliedIndex:15460; }","duration":"135.621779ms","start":"2026-10-14T20:12:53.688539Z","end":"2026-10-14T20:12:53.824161Z","steps":["trace[1638366457] 'read index received' (duration: 57.631364ms)","trace[1638366457] 'applied index is now lower than readState.Index' (duration: 77.988745ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T20:12:53.824056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.528188ms","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-10-14T20:12:53.82438Z","caller":"traceutil/trace.go:171","msg":"trace[1142766611] transaction","detail":"{read_only:false; response_revision:14935; number_of_response:1; }","duration":"137.707975ms","start":"2026-10-14T20:12:53.686644Z","end":"2026-10-14T20:12:53.824352Z","steps":["trace[1142766611] 'process raft request' (duration: 59.607958ms)","trace[1142766611] 'compare' (duration: 77.533865ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T20:12:53.824411Z","caller":"traceutil/trace.go:171","msg":"trace[982688492] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14934; }","duration":"183.922037ms","start":"2026-10-14T20:12:53.64046Z","end":"2026-10-14T20:12:53.824383Z","steps":["trace[982688492] 'range keys from in-memory index tree' (duration: 183.346874ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:12:53.824556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.157531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-vsmbd\" ","response":"range_response_count:1 size:12360"} {"level":"warn","ts":"2026-10-14T20:12:53.824558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.012187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T20:12:53.824625Z","caller":"traceutil/trace.go:171","msg":"trace[540751990] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-vsmbd; range_end:; response_count:1; response_revision:14935; }","duration":"122.253713ms","start":"2026-10-14T20:12:53.702354Z","end":"2026-10-14T20:12:53.824607Z","steps":["trace[540751990] 'agreement among raft nodes before linearized reading' (duration: 122.066219ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:12:53.824638Z","caller":"traceutil/trace.go:171","msg":"trace[1153923143] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14935; }","duration":"136.13988ms","start":"2026-10-14T20:12:53.688478Z","end":"2026-10-14T20:12:53.824617Z","steps":["trace[1153923143] 'agreement among raft nodes before linearized reading' (duration: 136.014918ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:12:53.941325Z","caller":"traceutil/trace.go:171","msg":"trace[65006121] transaction","detail":"{read_only:false; response_revision:14937; number_of_response:1; }","duration":"112.410296ms","start":"2026-10-14T20:12:53.82889Z","end":"2026-10-14T20:12:53.9413Z","steps":["trace[65006121] 'process raft request' (duration: 112.201961ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:12:53.941531Z","caller":"traceutil/trace.go:171","msg":"trace[1953900944] linearizableReadLoop","detail":"{readStateIndex:15463; appliedIndex:15461; }","duration":"111.746781ms","start":"2026-10-14T20:12:53.829758Z","end":"2026-10-14T20:12:53.941504Z","steps":["trace[1953900944] 'read index received' (duration: 25.439912ms)","trace[1953900944] 'applied index is now lower than readState.Index' (duration: 86.304959ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T20:12:53.941604Z","caller":"traceutil/trace.go:171","msg":"trace[1866884341] transaction","detail":"{read_only:false; response_revision:14938; number_of_response:1; }","duration":"102.696531ms","start":"2026-10-14T20:12:53.838892Z","end":"2026-10-14T20:12:53.941588Z","steps":["trace[1866884341] 'process raft request' (duration: 102.347873ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:12:53.941764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.981466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"} {"level":"info","ts":"2026-10-14T20:12:53.941801Z","caller":"traceutil/trace.go:171","msg":"trace[698797975] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:14938; }","duration":"112.053499ms","start":"2026-10-14T20:12:53.829734Z","end":"2026-10-14T20:12:53.941787Z","steps":["trace[698797975] 'agreement among raft nodes before linearized reading' (duration: 111.892175ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:12:54.64058Z","caller":"traceutil/trace.go:171","msg":"trace[214949233] linearizableReadLoop","detail":"{readStateIndex:15469; appliedIndex:15468; }","duration":"379.951152ms","start":"2026-10-14T20:12:54.260607Z","end":"2026-10-14T20:12:54.640558Z","steps":["trace[214949233] 'read index received' (duration: 379.782559ms)","trace[214949233] 'applied index is now lower than readState.Index' (duration: 167.533µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T20:12:54.640684Z","caller":"traceutil/trace.go:171","msg":"trace[1173734427] transaction","detail":"{read_only:false; response_revision:14943; number_of_response:1; }","duration":"605.90535ms","start":"2026-10-14T20:12:54.034721Z","end":"2026-10-14T20:12:54.640626Z","steps":["trace[1173734427] 'process raft request' (duration: 605.695175ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:12:54.640773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.156736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-ggf4q\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-10-14T20:12:54.640805Z","caller":"traceutil/trace.go:171","msg":"trace[1364523192] range","detail":"{range_begin:/registry/pods/openstack/keepalived-ggf4q; range_end:; response_count:1; response_revision:14943; }","duration":"380.205307ms","start":"2026-10-14T20:12:54.26059Z","end":"2026-10-14T20:12:54.640795Z","steps":["trace[1364523192] 'agreement among raft nodes before linearized reading' (duration: 380.070154ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:12:54.640855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:12:54.260534Z","time spent":"380.313011ms","remote":"127.0.0.1:35020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6543,"request content":"key:\"/registry/pods/openstack/keepalived-ggf4q\" "} {"level":"warn","ts":"2026-10-14T20:12:54.640939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:12:54.034692Z","time spent":"606.129544ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T20:12:54.674734Z","caller":"traceutil/trace.go:171","msg":"trace[273657020] transaction","detail":"{read_only:false; response_revision:14944; number_of_response:1; }","duration":"191.267039ms","start":"2026-10-14T20:12:54.483438Z","end":"2026-10-14T20:12:54.674705Z","steps":["trace[273657020] 'process raft request' (duration: 191.007883ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:12:54.674814Z","caller":"traceutil/trace.go:171","msg":"trace[1905101506] transaction","detail":"{read_only:false; response_revision:14945; number_of_response:1; }","duration":"190.995293ms","start":"2026-10-14T20:12:54.483799Z","end":"2026-10-14T20:12:54.674795Z","steps":["trace[1905101506] 'process raft request' (duration: 190.797469ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:12:54.674863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.85026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-14T20:12:54.674931Z","caller":"traceutil/trace.go:171","msg":"trace[2090953254] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14945; }","duration":"242.979633ms","start":"2026-10-14T20:12:54.431936Z","end":"2026-10-14T20:12:54.674915Z","steps":["trace[2090953254] 'agreement among raft nodes before linearized reading' (duration: 242.783579ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:13:04.885062Z","caller":"traceutil/trace.go:171","msg":"trace[467014849] linearizableReadLoop","detail":"{readStateIndex:15646; appliedIndex:15645; }","duration":"132.686535ms","start":"2026-10-14T20:13:04.752347Z","end":"2026-10-14T20:13:04.885033Z","steps":["trace[467014849] 'read index received' (duration: 11.809301ms)","trace[467014849] 'applied index is now lower than readState.Index' (duration: 120.875934ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T20:13:04.885162Z","caller":"traceutil/trace.go:171","msg":"trace[1404843166] transaction","detail":"{read_only:false; response_revision:15117; number_of_response:1; }","duration":"136.043158ms","start":"2026-10-14T20:13:04.749071Z","end":"2026-10-14T20:13:04.885114Z","steps":["trace[1404843166] 'process raft request' (duration: 108.928489ms)","trace[1404843166] 'compare' (duration: 26.909145ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T20:13:04.885239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.878139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-ggf4q\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-10-14T20:13:04.885299Z","caller":"traceutil/trace.go:171","msg":"trace[1332545306] range","detail":"{range_begin:/registry/pods/openstack/keepalived-ggf4q; range_end:; response_count:1; response_revision:15117; }","duration":"132.96075ms","start":"2026-10-14T20:13:04.752323Z","end":"2026-10-14T20:13:04.885283Z","steps":["trace[1332545306] 'agreement among raft nodes before linearized reading' (duration: 132.815637ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:13:05.198135Z","caller":"traceutil/trace.go:171","msg":"trace[1977722546] transaction","detail":"{read_only:false; response_revision:15119; number_of_response:1; }","duration":"253.126798ms","start":"2026-10-14T20:13:04.944983Z","end":"2026-10-14T20:13:05.19811Z","steps":["trace[1977722546] 'process raft request' (duration: 252.942514ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:13:05.54685Z","caller":"traceutil/trace.go:171","msg":"trace[197680036] linearizableReadLoop","detail":"{readStateIndex:15649; appliedIndex:15647; }","duration":"351.511483ms","start":"2026-10-14T20:13:05.195293Z","end":"2026-10-14T20:13:05.546804Z","steps":["trace[197680036] 'read index received' (duration: 2.686339ms)","trace[197680036] 'applied index is now lower than readState.Index' (duration: 348.823964ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T20:13:05.546913Z","caller":"traceutil/trace.go:171","msg":"trace[684437090] transaction","detail":"{read_only:false; response_revision:15120; number_of_response:1; }","duration":"558.498101ms","start":"2026-10-14T20:13:04.988383Z","end":"2026-10-14T20:13:05.546881Z","steps":["trace[684437090] 'process raft request' (duration: 558.279056ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:13:05.547112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.797109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/ovn-controller-default-hcpvn.18de7e7e88fe1e78\" ","response":"range_response_count:1 size:783"} {"level":"warn","ts":"2026-10-14T20:13:05.54715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:13:04.988362Z","time spent":"558.667314ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T20:13:05.547197Z","caller":"traceutil/trace.go:171","msg":"trace[882921578] range","detail":"{range_begin:/registry/events/openstack/ovn-controller-default-hcpvn.18de7e7e88fe1e78; range_end:; response_count:1; response_revision:15120; }","duration":"351.935913ms","start":"2026-10-14T20:13:05.19524Z","end":"2026-10-14T20:13:05.547176Z","steps":["trace[882921578] 'agreement among raft nodes before linearized reading' (duration: 351.680157ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:13:05.547191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.222655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-80e16f1b-2c7e-4c28-b7cc-74db61e25cbf\" ","response":"range_response_count:1 size:3606"} {"level":"warn","ts":"2026-10-14T20:13:05.54725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:13:05.195216Z","time spent":"352.022785ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":806,"request content":"key:\"/registry/events/openstack/ovn-controller-default-hcpvn.18de7e7e88fe1e78\" "} {"level":"info","ts":"2026-10-14T20:13:05.547306Z","caller":"traceutil/trace.go:171","msg":"trace[439479093] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-80e16f1b-2c7e-4c28-b7cc-74db61e25cbf; range_end:; response_count:1; response_revision:15120; }","duration":"345.394888ms","start":"2026-10-14T20:13:05.201883Z","end":"2026-10-14T20:13:05.547278Z","steps":["trace[439479093] 'agreement among raft nodes before linearized reading' (duration: 345.099001ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:13:05.547376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:13:05.201855Z","time spent":"345.503791ms","remote":"127.0.0.1:35020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3629,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-80e16f1b-2c7e-4c28-b7cc-74db61e25cbf\" "} {"level":"info","ts":"2026-10-14T20:14:35.273716Z","caller":"traceutil/trace.go:171","msg":"trace[1529840134] transaction","detail":"{read_only:false; response_revision:16157; number_of_response:1; }","duration":"208.340111ms","start":"2026-10-14T20:14:35.065352Z","end":"2026-10-14T20:14:35.273692Z","steps":["trace[1529840134] 'process raft request' (duration: 208.198058ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:14:35.281686Z","caller":"traceutil/trace.go:171","msg":"trace[1927191075] transaction","detail":"{read_only:false; response_revision:16158; number_of_response:1; }","duration":"212.256009ms","start":"2026-10-14T20:14:35.069409Z","end":"2026-10-14T20:14:35.281665Z","steps":["trace[1927191075] 'process raft request' (duration: 212.098695ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:14:35.28167Z","caller":"traceutil/trace.go:171","msg":"trace[1526657731] linearizableReadLoop","detail":"{readStateIndex:16717; appliedIndex:16716; }","duration":"187.907486ms","start":"2026-10-14T20:14:35.093736Z","end":"2026-10-14T20:14:35.281644Z","steps":["trace[1526657731] 'read index received' (duration: 180.063231ms)","trace[1526657731] 'applied index is now lower than readState.Index' (duration: 7.843235ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T20:14:35.2818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.041949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T20:14:35.281867Z","caller":"traceutil/trace.go:171","msg":"trace[1278980634] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16158; }","duration":"188.158102ms","start":"2026-10-14T20:14:35.093697Z","end":"2026-10-14T20:14:35.281855Z","steps":["trace[1278980634] 'agreement among raft nodes before linearized reading' (duration: 188.022229ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:14:35.282076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.492691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-14T20:14:35.282091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.493468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:682"} {"level":"info","ts":"2026-10-14T20:14:35.282133Z","caller":"traceutil/trace.go:171","msg":"trace[270566840] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:16158; }","duration":"180.585353ms","start":"2026-10-14T20:14:35.101533Z","end":"2026-10-14T20:14:35.282118Z","steps":["trace[270566840] 'agreement among raft nodes before linearized reading' (duration: 180.489011ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:14:35.282159Z","caller":"traceutil/trace.go:171","msg":"trace[1262091897] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:16158; }","duration":"183.59473ms","start":"2026-10-14T20:14:35.098544Z","end":"2026-10-14T20:14:35.282138Z","steps":["trace[1262091897] 'agreement among raft nodes before linearized reading' (duration: 183.395816ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:14:35.282374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.385596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-10-14T20:14:35.28245Z","caller":"traceutil/trace.go:171","msg":"trace[340499350] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16158; }","duration":"183.489338ms","start":"2026-10-14T20:14:35.098943Z","end":"2026-10-14T20:14:35.282432Z","steps":["trace[340499350] 'agreement among raft nodes before linearized reading' (duration: 183.252892ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:14:35.282499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.835587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-10-14T20:14:35.282551Z","caller":"traceutil/trace.go:171","msg":"trace[1034725105] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16158; }","duration":"166.912318ms","start":"2026-10-14T20:14:35.115627Z","end":"2026-10-14T20:14:35.282539Z","steps":["trace[1034725105] 'agreement among raft nodes before linearized reading' (duration: 166.329775ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:14:36.152716Z","caller":"traceutil/trace.go:171","msg":"trace[1040335877] linearizableReadLoop","detail":"{readStateIndex:16719; appliedIndex:16718; }","duration":"119.798039ms","start":"2026-10-14T20:14:36.032889Z","end":"2026-10-14T20:14:36.152688Z","steps":["trace[1040335877] 'read index received' (duration: 119.604224ms)","trace[1040335877] 'applied index is now lower than readState.Index' (duration: 192.715µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T20:14:36.152814Z","caller":"traceutil/trace.go:171","msg":"trace[1202906475] transaction","detail":"{read_only:false; response_revision:16160; number_of_response:1; }","duration":"141.450162ms","start":"2026-10-14T20:14:36.011316Z","end":"2026-10-14T20:14:36.152766Z","steps":["trace[1202906475] 'process raft request' (duration: 141.193526ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:14:36.152907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.006413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T20:14:36.152946Z","caller":"traceutil/trace.go:171","msg":"trace[950819261] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16160; }","duration":"120.135646ms","start":"2026-10-14T20:14:36.032801Z","end":"2026-10-14T20:14:36.152936Z","steps":["trace[950819261] 'agreement among raft nodes before linearized reading' (duration: 120.052944ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:14:36.153154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.514349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"warn","ts":"2026-10-14T20:14:36.153145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.190598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-10-14T20:14:36.153196Z","caller":"traceutil/trace.go:171","msg":"trace[1681033767] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16160; }","duration":"113.56899ms","start":"2026-10-14T20:14:36.039616Z","end":"2026-10-14T20:14:36.153185Z","steps":["trace[1681033767] 'agreement among raft nodes before linearized reading' (duration: 113.401686ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:14:36.153233Z","caller":"traceutil/trace.go:171","msg":"trace[1314931439] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16160; }","duration":"116.312941ms","start":"2026-10-14T20:14:36.036893Z","end":"2026-10-14T20:14:36.153206Z","steps":["trace[1314931439] 'agreement among raft nodes before linearized reading' (duration: 116.035975ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:14:36.604463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.064649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-10-14T20:14:36.604541Z","caller":"traceutil/trace.go:171","msg":"trace[2052828861] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16160; }","duration":"403.184912ms","start":"2026-10-14T20:14:36.201338Z","end":"2026-10-14T20:14:36.604523Z","steps":["trace[2052828861] 'range keys from in-memory index tree' (duration: 402.830884ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:14:36.604581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:14:36.201313Z","time spent":"403.258003ms","remote":"127.0.0.1:34998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":691,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "} {"level":"warn","ts":"2026-10-14T20:14:36.605388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.026401ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T20:14:36.605494Z","caller":"traceutil/trace.go:171","msg":"trace[2000046004] linearizableReadLoop","detail":"{readStateIndex:16720; appliedIndex:16719; }","duration":"229.097424ms","start":"2026-10-14T20:14:36.37638Z","end":"2026-10-14T20:14:36.605478Z","steps":["trace[2000046004] 'read index received' (duration: 39.93825ms)","trace[2000046004] 'applied index is now lower than readState.Index' (duration: 189.157324ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T20:14:36.605876Z","caller":"traceutil/trace.go:171","msg":"trace[1599713745] transaction","detail":"{read_only:false; response_revision:16161; number_of_response:1; }","duration":"243.862633ms","start":"2026-10-14T20:14:36.361993Z","end":"2026-10-14T20:14:36.605856Z","steps":["trace[1599713745] 'process raft request' (duration: 54.29667ms)","trace[1599713745] 'compare' (duration: 188.936759ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T20:14:36.606049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.847925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-4ldlj\" ","response":"range_response_count:1 size:9798"} {"level":"warn","ts":"2026-10-14T20:14:36.606078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.1706ms","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-10-14T20:14:36.606138Z","caller":"traceutil/trace.go:171","msg":"trace[895831975] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-4ldlj; range_end:; response_count:1; response_revision:16161; }","duration":"210.032179ms","start":"2026-10-14T20:14:36.396083Z","end":"2026-10-14T20:14:36.606115Z","steps":["trace[895831975] 'agreement among raft nodes before linearized reading' (duration: 209.681481ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:14:36.60615Z","caller":"traceutil/trace.go:171","msg":"trace[762952501] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:16161; }","duration":"139.317344ms","start":"2026-10-14T20:14:36.466816Z","end":"2026-10-14T20:14:36.606133Z","steps":["trace[762952501] 'agreement among raft nodes before linearized reading' (duration: 139.11826ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:14:36.606141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.751548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-14T20:14:36.606469Z","caller":"traceutil/trace.go:171","msg":"trace[195768179] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16161; }","duration":"230.126566ms","start":"2026-10-14T20:14:36.376319Z","end":"2026-10-14T20:14:36.606446Z","steps":["trace[195768179] 'agreement among raft nodes before linearized reading' (duration: 229.633215ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:16:54.401731Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14575} {"level":"info","ts":"2026-10-14T20:16:54.482961Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14575,"took":"78.57817ms","hash":47129894,"current-db-size-bytes":56213504,"current-db-size":"56 MB","current-db-size-in-use-bytes":31944704,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-14T20:16:54.483102Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":47129894,"revision":14575,"compact-revision":12542} {"level":"info","ts":"2026-10-14T20:20:27.647476Z","caller":"traceutil/trace.go:171","msg":"trace[1627780063] transaction","detail":"{read_only:false; response_revision:18721; number_of_response:1; }","duration":"140.24994ms","start":"2026-10-14T20:20:27.50719Z","end":"2026-10-14T20:20:27.64744Z","steps":["trace[1627780063] 'process raft request' (duration: 140.037676ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:20:28.204023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.386912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-14T20:20:28.204107Z","caller":"traceutil/trace.go:171","msg":"trace[745260330] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:18722; }","duration":"200.520905ms","start":"2026-10-14T20:20:28.003568Z","end":"2026-10-14T20:20:28.204089Z","steps":["trace[745260330] 'count revisions from in-memory index tree' (duration: 200.26447ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:20:28.329787Z","caller":"traceutil/trace.go:171","msg":"trace[1959937387] linearizableReadLoop","detail":"{readStateIndex:19369; appliedIndex:19368; }","duration":"253.328442ms","start":"2026-10-14T20:20:28.076435Z","end":"2026-10-14T20:20:28.329764Z","steps":["trace[1959937387] 'read index received' (duration: 252.80147ms)","trace[1959937387] 'applied index is now lower than readState.Index' (duration: 525.782µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T20:20:28.329967Z","caller":"traceutil/trace.go:171","msg":"trace[1313307268] transaction","detail":"{read_only:false; response_revision:18723; number_of_response:1; }","duration":"293.391112ms","start":"2026-10-14T20:20:28.036537Z","end":"2026-10-14T20:20:28.329928Z","steps":["trace[1313307268] 'process raft request' (duration: 293.075034ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:20:28.329998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.536826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T20:20:28.330185Z","caller":"traceutil/trace.go:171","msg":"trace[485291802] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:18723; }","duration":"253.74891ms","start":"2026-10-14T20:20:28.076398Z","end":"2026-10-14T20:20:28.330147Z","steps":["trace[485291802] 'agreement among raft nodes before linearized reading' (duration: 253.507305ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:20:28.949395Z","caller":"traceutil/trace.go:171","msg":"trace[836476720] linearizableReadLoop","detail":"{readStateIndex:19370; appliedIndex:19369; }","duration":"380.381276ms","start":"2026-10-14T20:20:28.568989Z","end":"2026-10-14T20:20:28.949371Z","steps":["trace[836476720] 'read index received' (duration: 379.922926ms)","trace[836476720] 'applied index is now lower than readState.Index' (duration: 457.47µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T20:20:28.949496Z","caller":"traceutil/trace.go:171","msg":"trace[2089813120] transaction","detail":"{read_only:false; response_revision:18724; number_of_response:1; }","duration":"573.953824ms","start":"2026-10-14T20:20:28.375508Z","end":"2026-10-14T20:20:28.949462Z","steps":["trace[2089813120] 'process raft request' (duration: 573.500664ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:20:28.949624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:20:28.375479Z","time spent":"574.065057ms","remote":"127.0.0.1:55626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417994,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T20:20:28.949669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.633232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-14T20:20:28.94976Z","caller":"traceutil/trace.go:171","msg":"trace[1799581801] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:18724; }","duration":"380.803985ms","start":"2026-10-14T20:20:28.568935Z","end":"2026-10-14T20:20:28.949739Z","steps":["trace[1799581801] 'agreement among raft nodes before linearized reading' (duration: 380.536549ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:20:28.949809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:20:28.568905Z","time spent":"380.892088ms","remote":"127.0.0.1:35174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":115,"response size":31,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-10-14T20:20:28.986902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.715642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"warn","ts":"2026-10-14T20:20:28.987244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.910212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T20:20:28.987324Z","caller":"traceutil/trace.go:171","msg":"trace[1697240377] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:18726; }","duration":"341.981063ms","start":"2026-10-14T20:20:28.645321Z","end":"2026-10-14T20:20:28.987302Z","steps":["trace[1697240377] 'agreement among raft nodes before linearized reading' (duration: 341.894501ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:20:28.987328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.974613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2083"} {"level":"info","ts":"2026-10-14T20:20:28.987409Z","caller":"traceutil/trace.go:171","msg":"trace[2050607271] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:18726; }","duration":"180.119496ms","start":"2026-10-14T20:20:28.807277Z","end":"2026-10-14T20:20:28.987396Z","steps":["trace[2050607271] 'agreement among raft nodes before linearized reading' (duration: 179.897751ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:20:28.987438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.804645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-14T20:20:28.987471Z","caller":"traceutil/trace.go:171","msg":"trace[970649967] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18726; }","duration":"323.860906ms","start":"2026-10-14T20:20:28.6636Z","end":"2026-10-14T20:20:28.987461Z","steps":["trace[970649967] 'agreement among raft nodes before linearized reading' (duration: 323.780984ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:20:28.987493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:20:28.663583Z","time spent":"323.904647ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-14T20:20:28.98725Z","caller":"traceutil/trace.go:171","msg":"trace[660924827] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:18726; }","duration":"417.155352ms","start":"2026-10-14T20:20:28.570071Z","end":"2026-10-14T20:20:28.987227Z","steps":["trace[660924827] 'agreement among raft nodes before linearized reading' (duration: 416.63373ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:20:28.987647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:20:28.570046Z","time spent":"417.591152ms","remote":"127.0.0.1:35020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-10-14T20:20:28.987808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.879961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-14T20:20:28.987836Z","caller":"traceutil/trace.go:171","msg":"trace[2076556798] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18726; }","duration":"402.963623ms","start":"2026-10-14T20:20:28.584864Z","end":"2026-10-14T20:20:28.987828Z","steps":["trace[2076556798] 'agreement among raft nodes before linearized reading' (duration: 402.881141ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:20:28.98786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:20:28.584843Z","time spent":"403.010884ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-14T20:20:28.987362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:20:28.64528Z","time spent":"342.071735ms","remote":"127.0.0.1:55792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-10-14T20:20:28.987151Z","caller":"traceutil/trace.go:171","msg":"trace[1614644967] transaction","detail":"{read_only:false; response_revision:18725; number_of_response:1; }","duration":"371.66337ms","start":"2026-10-14T20:20:28.61548Z","end":"2026-10-14T20:20:28.987143Z","steps":["trace[1614644967] 'process raft request' (duration: 361.378919ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:20:28.988202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:20:28.615457Z","time spent":"372.693833ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T20:20:28.987614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.472874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-10-14T20:20:28.987156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.399218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-14T20:20:28.988331Z","caller":"traceutil/trace.go:171","msg":"trace[1037813318] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18726; }","duration":"309.614246ms","start":"2026-10-14T20:20:28.67871Z","end":"2026-10-14T20:20:28.988324Z","steps":["trace[1037813318] 'agreement among raft nodes before linearized reading' (duration: 308.294107ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:20:28.988337Z","caller":"traceutil/trace.go:171","msg":"trace[1063051076] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18726; }","duration":"355.235191ms","start":"2026-10-14T20:20:28.633085Z","end":"2026-10-14T20:20:28.98832Z","steps":["trace[1063051076] 'agreement among raft nodes before linearized reading' (duration: 354.202778ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:20:28.988384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:20:28.633071Z","time spent":"355.297792ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-14T20:20:28.988351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:20:28.6787Z","time spent":"309.645077ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-14T20:20:28.987092Z","caller":"traceutil/trace.go:171","msg":"trace[1650897875] transaction","detail":"{read_only:false; response_revision:18726; number_of_response:1; }","duration":"315.535059ms","start":"2026-10-14T20:20:28.671524Z","end":"2026-10-14T20:20:28.987059Z","steps":["trace[1650897875] 'process raft request' (duration: 315.110069ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:20:28.988534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:20:28.671507Z","time spent":"316.986382ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T20:20:38.54056Z","caller":"traceutil/trace.go:171","msg":"trace[1876199885] transaction","detail":"{read_only:false; response_revision:18929; number_of_response:1; }","duration":"112.538519ms","start":"2026-10-14T20:20:38.427994Z","end":"2026-10-14T20:20:38.540533Z","steps":["trace[1876199885] 'process raft request' (duration: 104.313184ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:21:16.009006Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1e882206af630b31","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-14T20:21:16.015737Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-14T20:21:16.01587Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-14T20:21:54.409552Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17086} {"level":"info","ts":"2026-10-14T20:21:54.517872Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17086,"took":"104.931287ms","hash":4270774560,"current-db-size-bytes":56213504,"current-db-size":"56 MB","current-db-size-in-use-bytes":34521088,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-14T20:21:54.517961Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4270774560,"revision":17086,"compact-revision":14575} {"level":"info","ts":"2026-10-14T20:26:08.893878Z","caller":"traceutil/trace.go:171","msg":"trace[1401897978] transaction","detail":"{read_only:false; response_revision:21398; number_of_response:1; }","duration":"115.618993ms","start":"2026-10-14T20:26:08.778225Z","end":"2026-10-14T20:26:08.893844Z","steps":["trace[1401897978] 'process raft request' (duration: 115.399818ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:26:08.917135Z","caller":"traceutil/trace.go:171","msg":"trace[1976770628] transaction","detail":"{read_only:false; response_revision:21399; number_of_response:1; }","duration":"138.663915ms","start":"2026-10-14T20:26:08.778441Z","end":"2026-10-14T20:26:08.917105Z","steps":["trace[1976770628] 'process raft request' (duration: 138.390249ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:26:24.902791Z","caller":"traceutil/trace.go:171","msg":"trace[525108836] transaction","detail":"{read_only:false; response_revision:21482; number_of_response:1; }","duration":"338.329531ms","start":"2026-10-14T20:26:24.564432Z","end":"2026-10-14T20:26:24.902762Z","steps":["trace[525108836] 'process raft request' (duration: 338.181478ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:26:24.902995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:26:24.564411Z","time spent":"338.461974ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T20:26:25.34643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.618191ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-14T20:26:25.346545Z","caller":"traceutil/trace.go:171","msg":"trace[1072718297] transaction","detail":"{read_only:false; response_revision:21483; number_of_response:1; }","duration":"687.455682ms","start":"2026-10-14T20:26:24.659057Z","end":"2026-10-14T20:26:25.346512Z","steps":["trace[1072718297] 'process raft request' (duration: 397.656317ms)","trace[1072718297] 'compare' (duration: 289.315185ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T20:26:25.346674Z","caller":"traceutil/trace.go:171","msg":"trace[1566412366] transaction","detail":"{read_only:false; response_revision:21484; number_of_response:1; }","duration":"362.61321ms","start":"2026-10-14T20:26:24.984044Z","end":"2026-10-14T20:26:25.346657Z","steps":["trace[1566412366] 'process raft request' (duration: 362.478868ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:26:25.346729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:26:24.659031Z","time spent":"687.601975ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T20:26:25.346741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:26:24.984015Z","time spent":"362.694512ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T20:26:25.346826Z","caller":"traceutil/trace.go:171","msg":"trace[1886034203] linearizableReadLoop","detail":"{readStateIndex:22217; appliedIndex:22215; }","duration":"658.679934ms","start":"2026-10-14T20:26:24.687982Z","end":"2026-10-14T20:26:25.346662Z","steps":["trace[1886034203] 'read index received' (duration: 214.630788ms)","trace[1886034203] 'applied index is now lower than readState.Index' (duration: 444.046206ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T20:26:25.346968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.984091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T20:26:25.347009Z","caller":"traceutil/trace.go:171","msg":"trace[513161916] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21484; }","duration":"659.082383ms","start":"2026-10-14T20:26:24.687913Z","end":"2026-10-14T20:26:25.346995Z","steps":["trace[513161916] 'agreement among raft nodes before linearized reading' (duration: 658.998531ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:26:25.347035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:26:24.687888Z","time spent":"659.142055ms","remote":"127.0.0.1:34804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-14T20:26:25.347164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.288895ms","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:8"} {"level":"warn","ts":"2026-10-14T20:26:25.347206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.480771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-10-14T20:26:25.347216Z","caller":"traceutil/trace.go:171","msg":"trace[143290522] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:21484; }","duration":"188.364697ms","start":"2026-10-14T20:26:25.158837Z","end":"2026-10-14T20:26:25.347201Z","steps":["trace[143290522] 'agreement among raft nodes before linearized reading' (duration: 188.252094ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:26:25.347212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.234683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-14T20:26:25.347242Z","caller":"traceutil/trace.go:171","msg":"trace[552219135] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21484; }","duration":"355.553603ms","start":"2026-10-14T20:26:24.991678Z","end":"2026-10-14T20:26:25.347232Z","steps":["trace[552219135] 'agreement among raft nodes before linearized reading' (duration: 355.4287ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:26:25.347276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:26:24.991662Z","time spent":"355.607605ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-14T20:26:25.347283Z","caller":"traceutil/trace.go:171","msg":"trace[753078275] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21484; }","duration":"312.376336ms","start":"2026-10-14T20:26:25.034887Z","end":"2026-10-14T20:26:25.347263Z","steps":["trace[753078275] 'agreement among raft nodes before linearized reading' (duration: 312.153831ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:26:25.347274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.73427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-10-14T20:26:25.347321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:26:25.034864Z","time spent":"312.447858ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-14T20:26:25.347343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.87717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" ","response":"range_response_count:1 size:1864"} {"level":"info","ts":"2026-10-14T20:26:25.347373Z","caller":"traceutil/trace.go:171","msg":"trace[39930944] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21484; }","duration":"361.878744ms","start":"2026-10-14T20:26:24.985467Z","end":"2026-10-14T20:26:25.347345Z","steps":["trace[39930944] 'agreement among raft nodes before linearized reading' (duration: 361.658599ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:26:25.347402Z","caller":"traceutil/trace.go:171","msg":"trace[46619525] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0; range_end:; response_count:1; response_revision:21484; }","duration":"507.984243ms","start":"2026-10-14T20:26:24.839402Z","end":"2026-10-14T20:26:25.347386Z","steps":["trace[46619525] 'agreement among raft nodes before linearized reading' (duration: 507.776938ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:26:25.347426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:26:24.985445Z","time spent":"361.967505ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-14T20:26:25.347437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:26:24.839383Z","time spent":"508.046545ms","remote":"127.0.0.1:34988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" "} {"level":"warn","ts":"2026-10-14T20:26:25.347644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.318607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-10-14T20:26:25.34774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.336421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T20:26:25.347766Z","caller":"traceutil/trace.go:171","msg":"trace[1576062522] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21484; }","duration":"313.500311ms","start":"2026-10-14T20:26:25.034233Z","end":"2026-10-14T20:26:25.347733Z","steps":["trace[1576062522] 'agreement among raft nodes before linearized reading' (duration: 313.00458ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:26:25.347786Z","caller":"traceutil/trace.go:171","msg":"trace[1565881411] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:21484; }","duration":"651.494945ms","start":"2026-10-14T20:26:24.696277Z","end":"2026-10-14T20:26:25.347772Z","steps":["trace[1565881411] 'agreement among raft nodes before linearized reading' (duration: 650.755209ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:26:25.347831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:26:24.696263Z","time spent":"651.558236ms","remote":"127.0.0.1:55848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-10-14T20:26:25.34784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:26:25.034209Z","time spent":"313.620853ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-14T20:26:25.6222Z","caller":"traceutil/trace.go:171","msg":"trace[634652488] transaction","detail":"{read_only:false; response_revision:21486; number_of_response:1; }","duration":"270.042287ms","start":"2026-10-14T20:26:25.352132Z","end":"2026-10-14T20:26:25.622175Z","steps":["trace[634652488] 'process raft request' (duration: 223.182728ms)","trace[634652488] 'compare' (duration: 46.526942ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T20:26:25.622557Z","caller":"traceutil/trace.go:171","msg":"trace[1791571601] transaction","detail":"{read_only:false; response_revision:21487; number_of_response:1; }","duration":"270.060368ms","start":"2026-10-14T20:26:25.352464Z","end":"2026-10-14T20:26:25.622525Z","steps":["trace[1791571601] 'process raft request' (duration: 269.633659ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:26:25.62267Z","caller":"traceutil/trace.go:171","msg":"trace[1012986837] transaction","detail":"{read_only:false; response_revision:21488; number_of_response:1; }","duration":"269.655819ms","start":"2026-10-14T20:26:25.352977Z","end":"2026-10-14T20:26:25.622633Z","steps":["trace[1012986837] 'process raft request' (duration: 269.364022ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:26:25.622787Z","caller":"traceutil/trace.go:171","msg":"trace[951100349] linearizableReadLoop","detail":"{readStateIndex:22223; appliedIndex:22219; }","duration":"248.378047ms","start":"2026-10-14T20:26:25.374385Z","end":"2026-10-14T20:26:25.622763Z","steps":["trace[951100349] 'read index received' (duration: 43.843092ms)","trace[951100349] 'applied index is now lower than readState.Index' (duration: 204.533725ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T20:26:25.622895Z","caller":"traceutil/trace.go:171","msg":"trace[272225474] transaction","detail":"{read_only:false; response_revision:21489; number_of_response:1; }","duration":"267.204965ms","start":"2026-10-14T20:26:25.355663Z","end":"2026-10-14T20:26:25.622868Z","steps":["trace[272225474] 'process raft request' (duration: 266.885208ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:26:25.623039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.635093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-10-14T20:26:25.623084Z","caller":"traceutil/trace.go:171","msg":"trace[1363747111] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:21489; }","duration":"248.722645ms","start":"2026-10-14T20:26:25.374349Z","end":"2026-10-14T20:26:25.623072Z","steps":["trace[1363747111] 'agreement among raft nodes before linearized reading' (duration: 248.511571ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:26:26.014202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.407145ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-14T20:26:26.014464Z","caller":"traceutil/trace.go:171","msg":"trace[657731419] transaction","detail":"{read_only:false; response_revision:21491; number_of_response:1; }","duration":"315.535175ms","start":"2026-10-14T20:26:25.698772Z","end":"2026-10-14T20:26:26.014307Z","steps":["trace[657731419] 'process raft request' (duration: 136.733211ms)","trace[657731419] 'compare' (duration: 178.201541ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T20:26:26.01455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:26:25.698748Z","time spent":"315.76247ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T20:26:54.418014Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19653} {"level":"info","ts":"2026-10-14T20:26:54.550477Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19653,"took":"126.690124ms","hash":940020290,"current-db-size-bytes":56213504,"current-db-size":"56 MB","current-db-size-in-use-bytes":29429760,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-14T20:26:54.550548Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":940020290,"revision":19653,"compact-revision":17086} {"level":"info","ts":"2026-10-14T20:30:30.406647Z","caller":"traceutil/trace.go:171","msg":"trace[1051320990] transaction","detail":"{read_only:false; response_revision:23999; number_of_response:1; }","duration":"297.121689ms","start":"2026-10-14T20:30:30.1095Z","end":"2026-10-14T20:30:30.406621Z","steps":["trace[1051320990] 'process raft request' (duration: 296.942385ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:30:30.407662Z","caller":"traceutil/trace.go:171","msg":"trace[38659477] transaction","detail":"{read_only:false; response_revision:24000; number_of_response:1; }","duration":"239.37265ms","start":"2026-10-14T20:30:30.168259Z","end":"2026-10-14T20:30:30.407632Z","steps":["trace[38659477] 'process raft request' (duration: 239.135105ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:31:54.430991Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21636} {"level":"info","ts":"2026-10-14T20:31:54.542254Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21636,"took":"107.518981ms","hash":1351111226,"current-db-size-bytes":56721408,"current-db-size":"57 MB","current-db-size-in-use-bytes":43376640,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-10-14T20:31:54.542411Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1351111226,"revision":21636,"compact-revision":19653} {"level":"info","ts":"2026-10-14T20:33:53.919453Z","caller":"traceutil/trace.go:171","msg":"trace[870119120] transaction","detail":"{read_only:false; response_revision:25979; number_of_response:1; }","duration":"122.704187ms","start":"2026-10-14T20:33:53.796711Z","end":"2026-10-14T20:33:53.919415Z","steps":["trace[870119120] 'process raft request' (duration: 122.40088ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:33:59.794668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.893859ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-14T20:33:59.794808Z","caller":"traceutil/trace.go:171","msg":"trace[1242947582] transaction","detail":"{read_only:false; response_revision:26022; number_of_response:1; }","duration":"458.84127ms","start":"2026-10-14T20:33:59.335948Z","end":"2026-10-14T20:33:59.79479Z","steps":["trace[1242947582] 'process raft request' (duration: 205.710445ms)","trace[1242947582] 'compare' (duration: 252.615303ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T20:33:59.794863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:33:59.335929Z","time spent":"458.906681ms","remote":"127.0.0.1:34898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":677,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T20:34:00.16807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.015984ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-14T20:34:00.168636Z","caller":"traceutil/trace.go:171","msg":"trace[728930311] linearizableReadLoop","detail":"{readStateIndex:26885; appliedIndex:26883; }","duration":"480.306294ms","start":"2026-10-14T20:33:59.688282Z","end":"2026-10-14T20:34:00.168589Z","steps":["trace[728930311] 'read index received' (duration: 272.653116ms)","trace[728930311] 'applied index is now lower than readState.Index' (duration: 207.651988ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T20:34:00.168799Z","caller":"traceutil/trace.go:171","msg":"trace[252457117] transaction","detail":"{read_only:false; response_revision:26023; number_of_response:1; }","duration":"726.6908ms","start":"2026-10-14T20:33:59.442068Z","end":"2026-10-14T20:34:00.168759Z","steps":["trace[252457117] 'process raft request' (duration: 518.808467ms)","trace[252457117] 'compare' (duration: 206.204056ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T20:34:00.168847Z","caller":"traceutil/trace.go:171","msg":"trace[1150898288] transaction","detail":"{read_only:false; response_revision:26024; number_of_response:1; }","duration":"664.639345ms","start":"2026-10-14T20:33:59.504099Z","end":"2026-10-14T20:34:00.168738Z","steps":["trace[1150898288] 'process raft request' (duration: 664.139024ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:34:00.168965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:33:59.442046Z","time spent":"726.836613ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T20:34:00.16904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:33:59.504065Z","time spent":"664.84954ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T20:34:00.169287Z","caller":"traceutil/trace.go:171","msg":"trace[1627831752] transaction","detail":"{read_only:false; response_revision:26025; number_of_response:1; }","duration":"454.852351ms","start":"2026-10-14T20:33:59.714423Z","end":"2026-10-14T20:34:00.169275Z","steps":["trace[1627831752] 'process raft request' (duration: 453.976262ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:34:00.169355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:33:59.714392Z","time spent":"454.929102ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T20:34:00.16955Z","caller":"traceutil/trace.go:171","msg":"trace[1370848932] transaction","detail":"{read_only:false; response_revision:26026; number_of_response:1; }","duration":"230.929793ms","start":"2026-10-14T20:33:59.938609Z","end":"2026-10-14T20:34:00.169539Z","steps":["trace[1370848932] 'process raft request' (duration: 230.588376ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:34:00.16968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.397078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T20:34:00.169716Z","caller":"traceutil/trace.go:171","msg":"trace[1447014023] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26026; }","duration":"481.43271ms","start":"2026-10-14T20:33:59.688275Z","end":"2026-10-14T20:34:00.169707Z","steps":["trace[1447014023] 'agreement among raft nodes before linearized reading' (duration: 481.377089ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:34:00.169741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:33:59.688213Z","time spent":"481.522381ms","remote":"127.0.0.1:34804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-14T20:34:00.177274Z","caller":"traceutil/trace.go:171","msg":"trace[1629632534] transaction","detail":"{read_only:false; response_revision:26027; number_of_response:1; }","duration":"114.088167ms","start":"2026-10-14T20:34:00.063147Z","end":"2026-10-14T20:34:00.177235Z","steps":["trace[1629632534] 'process raft request' (duration: 113.881892ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:34:00.178079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.033327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-14T20:34:00.17813Z","caller":"traceutil/trace.go:171","msg":"trace[1986016543] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26027; }","duration":"227.144369ms","start":"2026-10-14T20:33:59.950973Z","end":"2026-10-14T20:34:00.178118Z","steps":["trace[1986016543] 'agreement among raft nodes before linearized reading' (duration: 226.926194ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:34:00.178142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.157992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11795"} {"level":"info","ts":"2026-10-14T20:34:00.178187Z","caller":"traceutil/trace.go:171","msg":"trace[262422990] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:26027; }","duration":"177.207023ms","start":"2026-10-14T20:34:00.000967Z","end":"2026-10-14T20:34:00.178174Z","steps":["trace[262422990] 'agreement among raft nodes before linearized reading' (duration: 176.567179ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:34:00.356718Z","caller":"traceutil/trace.go:171","msg":"trace[1071716740] transaction","detail":"{read_only:false; response_revision:26029; number_of_response:1; }","duration":"174.904302ms","start":"2026-10-14T20:34:00.181792Z","end":"2026-10-14T20:34:00.356697Z","steps":["trace[1071716740] 'process raft request' (duration: 174.708328ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:34:00.357102Z","caller":"traceutil/trace.go:171","msg":"trace[272120061] linearizableReadLoop","detail":"{readStateIndex:26891; appliedIndex:26889; }","duration":"162.872246ms","start":"2026-10-14T20:34:00.194155Z","end":"2026-10-14T20:34:00.357028Z","steps":["trace[272120061] 'read index received' (duration: 162.291904ms)","trace[272120061] 'applied index is now lower than readState.Index' (duration: 577.902µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T20:34:00.357143Z","caller":"traceutil/trace.go:171","msg":"trace[2050006838] transaction","detail":"{read_only:false; response_revision:26030; number_of_response:1; }","duration":"175.228789ms","start":"2026-10-14T20:34:00.181881Z","end":"2026-10-14T20:34:00.35711Z","steps":["trace[2050006838] 'process raft request' (duration: 174.774269ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:34:00.357374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.579076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11795"} {"level":"warn","ts":"2026-10-14T20:34:00.357436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.838087ms","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-10-14T20:34:00.357449Z","caller":"traceutil/trace.go:171","msg":"trace[345157459] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:26030; }","duration":"170.663398ms","start":"2026-10-14T20:34:00.186768Z","end":"2026-10-14T20:34:00.357431Z","steps":["trace[345157459] 'agreement among raft nodes before linearized reading' (duration: 170.434563ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:34:00.3575Z","caller":"traceutil/trace.go:171","msg":"trace[1845593173] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26030; }","duration":"158.940318ms","start":"2026-10-14T20:34:00.198542Z","end":"2026-10-14T20:34:00.357483Z","steps":["trace[1845593173] 'agreement among raft nodes before linearized reading' (duration: 158.746444ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:34:00.357647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.133361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-14T20:34:00.357681Z","caller":"traceutil/trace.go:171","msg":"trace[1751406270] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26030; }","duration":"158.182952ms","start":"2026-10-14T20:34:00.19949Z","end":"2026-10-14T20:34:00.357673Z","steps":["trace[1751406270] 'agreement among raft nodes before linearized reading' (duration: 158.09874ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:34:00.357623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.780567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-10-14T20:34:00.357735Z","caller":"traceutil/trace.go:171","msg":"trace[271182036] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26030; }","duration":"154.969332ms","start":"2026-10-14T20:34:00.202746Z","end":"2026-10-14T20:34:00.357715Z","steps":["trace[271182036] 'agreement among raft nodes before linearized reading' (duration: 154.621814ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:34:00.35803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.466001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T20:34:00.358091Z","caller":"traceutil/trace.go:171","msg":"trace[1021510615] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:26030; }","duration":"150.563903ms","start":"2026-10-14T20:34:00.207501Z","end":"2026-10-14T20:34:00.358065Z","steps":["trace[1021510615] 'agreement among raft nodes before linearized reading' (duration: 150.462321ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:34:28.321894Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006a3c.wal"} {"level":"info","ts":"2026-10-14T20:35:02.709261Z","caller":"traceutil/trace.go:171","msg":"trace[638072053] transaction","detail":"{read_only:false; response_revision:26599; number_of_response:1; }","duration":"305.726839ms","start":"2026-10-14T20:35:02.403502Z","end":"2026-10-14T20:35:02.709229Z","steps":["trace[638072053] 'process raft request' (duration: 305.503425ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:35:02.709481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:35:02.403471Z","time spent":"305.892902ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T20:35:02.91558Z","caller":"traceutil/trace.go:171","msg":"trace[1491840570] transaction","detail":"{read_only:false; response_revision:26601; number_of_response:1; }","duration":"507.300622ms","start":"2026-10-14T20:35:02.40825Z","end":"2026-10-14T20:35:02.915551Z","steps":["trace[1491840570] 'process raft request' (duration: 507.232411ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:35:02.91561Z","caller":"traceutil/trace.go:171","msg":"trace[1020104226] transaction","detail":"{read_only:false; response_revision:26600; number_of_response:1; }","duration":"509.533461ms","start":"2026-10-14T20:35:02.406038Z","end":"2026-10-14T20:35:02.915572Z","steps":["trace[1020104226] 'process raft request' (duration: 509.290036ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:35:02.915754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:35:02.408237Z","time spent":"507.421425ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T20:35:02.915773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:35:02.40598Z","time spent":"509.708996ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T20:35:02.91585Z","caller":"traceutil/trace.go:171","msg":"trace[728769343] transaction","detail":"{read_only:false; response_revision:26602; number_of_response:1; }","duration":"499.710724ms","start":"2026-10-14T20:35:02.416084Z","end":"2026-10-14T20:35:02.91582Z","steps":["trace[728769343] 'process raft request' (duration: 499.410438ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:35:02.915936Z","caller":"traceutil/trace.go:171","msg":"trace[1643046813] transaction","detail":"{read_only:false; response_revision:26603; number_of_response:1; }","duration":"498.049438ms","start":"2026-10-14T20:35:02.417874Z","end":"2026-10-14T20:35:02.915924Z","steps":["trace[1643046813] 'process raft request' (duration: 497.868494ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:35:02.915966Z","caller":"traceutil/trace.go:171","msg":"trace[63192076] linearizableReadLoop","detail":"{readStateIndex:27478; appliedIndex:27472; }","duration":"243.46177ms","start":"2026-10-14T20:35:02.672487Z","end":"2026-10-14T20:35:02.915949Z","steps":["trace[63192076] 'read index received' (duration: 36.553309ms)","trace[63192076] 'applied index is now lower than readState.Index' (duration: 206.907511ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T20:35:02.91599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:35:02.417834Z","time spent":"498.125779ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T20:35:02.91611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:35:02.416067Z","time spent":"499.865098ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T20:35:02.916224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.742167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-10-14T20:35:02.91627Z","caller":"traceutil/trace.go:171","msg":"trace[1143035348] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26605; }","duration":"243.836569ms","start":"2026-10-14T20:35:02.672421Z","end":"2026-10-14T20:35:02.916258Z","steps":["trace[1143035348] 'agreement among raft nodes before linearized reading' (duration: 243.623174ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:35:02.916259Z","caller":"traceutil/trace.go:171","msg":"trace[1523402691] transaction","detail":"{read_only:false; response_revision:26605; number_of_response:1; }","duration":"208.090777ms","start":"2026-10-14T20:35:02.708133Z","end":"2026-10-14T20:35:02.916224Z","steps":["trace[1523402691] 'process raft request' (duration: 207.77325ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:35:02.916663Z","caller":"traceutil/trace.go:171","msg":"trace[1104225083] transaction","detail":"{read_only:false; response_revision:26604; number_of_response:1; }","duration":"326.532719ms","start":"2026-10-14T20:35:02.589451Z","end":"2026-10-14T20:35:02.915984Z","steps":["trace[1104225083] 'process raft request' (duration: 326.408156ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:35:02.916728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:35:02.589424Z","time spent":"327.266536ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T20:35:03.146511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.180954ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-14T20:35:03.146744Z","caller":"traceutil/trace.go:171","msg":"trace[172722509] linearizableReadLoop","detail":"{readStateIndex:27480; appliedIndex:27479; }","duration":"230.698218ms","start":"2026-10-14T20:35:02.916027Z","end":"2026-10-14T20:35:03.146726Z","steps":["trace[172722509] 'read index received' (duration: 6.225158ms)","trace[172722509] 'applied index is now lower than readState.Index' (duration: 224.47217ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T20:35:03.146853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.289267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-14T20:35:03.146906Z","caller":"traceutil/trace.go:171","msg":"trace[1213974000] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26605; }","duration":"467.325677ms","start":"2026-10-14T20:35:02.67955Z","end":"2026-10-14T20:35:03.146876Z","steps":["trace[1213974000] 'agreement among raft nodes before linearized reading' (duration: 467.228535ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:35:03.146924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.662351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-14T20:35:03.146942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:35:02.679468Z","time spent":"467.46421ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-14T20:35:03.14696Z","caller":"traceutil/trace.go:171","msg":"trace[592985965] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26605; }","duration":"428.714902ms","start":"2026-10-14T20:35:02.718234Z","end":"2026-10-14T20:35:03.146949Z","steps":["trace[592985965] 'agreement among raft nodes before linearized reading' (duration: 428.63993ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:35:03.146986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:35:02.718224Z","time spent":"428.754634ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-14T20:35:03.146854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.417429ms","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-10-14T20:35:03.147024Z","caller":"traceutil/trace.go:171","msg":"trace[1983706017] transaction","detail":"{read_only:false; response_revision:26606; number_of_response:1; }","duration":"223.959659ms","start":"2026-10-14T20:35:02.923014Z","end":"2026-10-14T20:35:03.146973Z","steps":["trace[1983706017] 'process raft request' (duration: 223.622391ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:35:03.147079Z","caller":"traceutil/trace.go:171","msg":"trace[769956341] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26605; }","duration":"434.654104ms","start":"2026-10-14T20:35:02.71239Z","end":"2026-10-14T20:35:03.147044Z","steps":["trace[769956341] 'agreement among raft nodes before linearized reading' (duration: 434.356237ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:35:03.147202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:35:02.712377Z","time spent":"434.788007ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-14T20:35:03.256791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.202949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-14T20:35:03.256861Z","caller":"traceutil/trace.go:171","msg":"trace[1501742030] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:26606; }","duration":"577.311682ms","start":"2026-10-14T20:35:02.679533Z","end":"2026-10-14T20:35:03.256844Z","steps":["trace[1501742030] 'agreement among raft nodes before linearized reading' (duration: 467.384588ms)","trace[1501742030] 'count revisions from in-memory index tree' (duration: 109.820972ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T20:35:03.256893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:35:02.67952Z","time spent":"577.363863ms","remote":"127.0.0.1:55626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":31,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true "} {"level":"warn","ts":"2026-10-14T20:35:03.256876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.409348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-14T20:35:03.256962Z","caller":"traceutil/trace.go:171","msg":"trace[1014054750] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26606; }","duration":"560.546071ms","start":"2026-10-14T20:35:02.69639Z","end":"2026-10-14T20:35:03.256936Z","steps":["trace[1014054750] 'agreement among raft nodes before linearized reading' (duration: 450.505645ms)","trace[1014054750] 'range keys from in-memory index tree' (duration: 109.815482ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T20:35:03.257035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:35:02.696369Z","time spent":"560.639403ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-14T20:35:03.257573Z","caller":"traceutil/trace.go:171","msg":"trace[1069833873] transaction","detail":"{read_only:false; response_revision:26607; number_of_response:1; }","duration":"102.370636ms","start":"2026-10-14T20:35:03.155187Z","end":"2026-10-14T20:35:03.257557Z","steps":["trace[1069833873] 'process raft request' (duration: 80.969112ms)","trace[1069833873] 'compare' (duration: 21.151549ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T20:35:03.607845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.369944ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-14T20:35:03.608073Z","caller":"traceutil/trace.go:171","msg":"trace[1175567908] transaction","detail":"{read_only:false; response_revision:26608; number_of_response:1; }","duration":"452.836956ms","start":"2026-10-14T20:35:03.155204Z","end":"2026-10-14T20:35:03.608041Z","steps":["trace[1175567908] 'process raft request' (duration: 248.164495ms)","trace[1175567908] 'compare' (duration: 203.419603ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T20:35:03.60811Z","caller":"traceutil/trace.go:171","msg":"trace[1772096859] linearizableReadLoop","detail":"{readStateIndex:27484; appliedIndex:27481; }","duration":"440.38317ms","start":"2026-10-14T20:35:03.167705Z","end":"2026-10-14T20:35:03.608089Z","steps":["trace[1772096859] 'read index received' (duration: 68.475386ms)","trace[1772096859] 'applied index is now lower than readState.Index' (duration: 371.906364ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T20:35:03.608222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:35:03.155165Z","time spent":"452.98012ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-14T20:35:03.60824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.529414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-14T20:35:03.608285Z","caller":"traceutil/trace.go:171","msg":"trace[2026752494] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:26609; }","duration":"440.611875ms","start":"2026-10-14T20:35:03.167655Z","end":"2026-10-14T20:35:03.608267Z","steps":["trace[2026752494] 'agreement among raft nodes before linearized reading' (duration: 440.505103ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:35:03.608372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:35:03.167627Z","time spent":"440.730138ms","remote":"127.0.0.1:56564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true "} {"level":"info","ts":"2026-10-14T20:35:03.608597Z","caller":"traceutil/trace.go:171","msg":"trace[806151303] transaction","detail":"{read_only:false; response_revision:26609; number_of_response:1; }","duration":"451.895545ms","start":"2026-10-14T20:35:03.156686Z","end":"2026-10-14T20:35:03.608582Z","steps":["trace[806151303] 'process raft request' (duration: 451.282052ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:35:03.608662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:35:03.156672Z","time spent":"451.958606ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T20:35:03.642217Z","caller":"traceutil/trace.go:171","msg":"trace[782927599] transaction","detail":"{read_only:false; response_revision:26610; number_of_response:1; }","duration":"381.716171ms","start":"2026-10-14T20:35:03.260475Z","end":"2026-10-14T20:35:03.642191Z","steps":["trace[782927599] 'process raft request' (duration: 381.595269ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T20:35:03.642359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T20:35:03.260446Z","time spent":"381.841825ms","remote":"127.0.0.1:35112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T20:35:03.662846Z","caller":"traceutil/trace.go:171","msg":"trace[437078584] transaction","detail":"{read_only:false; response_revision:26611; number_of_response:1; }","duration":"247.174302ms","start":"2026-10-14T20:35:03.41565Z","end":"2026-10-14T20:35:03.662824Z","steps":["trace[437078584] 'process raft request' (duration: 247.018829ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:35:03.663235Z","caller":"traceutil/trace.go:171","msg":"trace[1692709909] transaction","detail":"{read_only:false; response_revision:26612; number_of_response:1; }","duration":"131.440471ms","start":"2026-10-14T20:35:03.531759Z","end":"2026-10-14T20:35:03.663199Z","steps":["trace[1692709909] 'process raft request' (duration: 131.010551ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:36:54.439327Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24900} {"level":"info","ts":"2026-10-14T20:36:54.647959Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24900,"took":"204.559134ms","hash":2528618000,"current-db-size-bytes":56721408,"current-db-size":"57 MB","current-db-size-in-use-bytes":35717120,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-14T20:36:54.64834Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2528618000,"revision":24900,"compact-revision":21636} {"level":"info","ts":"2026-10-14T20:38:43.744802Z","caller":"traceutil/trace.go:171","msg":"trace[739243656] transaction","detail":"{read_only:false; response_revision:28747; number_of_response:1; }","duration":"115.583662ms","start":"2026-10-14T20:38:43.629192Z","end":"2026-10-14T20:38:43.744776Z","steps":["trace[739243656] 'process raft request' (duration: 113.943706ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:38:44.217371Z","caller":"traceutil/trace.go:171","msg":"trace[33526009] transaction","detail":"{read_only:false; response_revision:28752; number_of_response:1; }","duration":"148.570894ms","start":"2026-10-14T20:38:44.068775Z","end":"2026-10-14T20:38:44.217346Z","steps":["trace[33526009] 'process raft request' (duration: 148.357189ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:38:44.217513Z","caller":"traceutil/trace.go:171","msg":"trace[1442519229] transaction","detail":"{read_only:false; response_revision:28753; number_of_response:1; }","duration":"144.735019ms","start":"2026-10-14T20:38:44.072746Z","end":"2026-10-14T20:38:44.217481Z","steps":["trace[1442519229] 'process raft request' (duration: 144.553005ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T20:39:12.322364Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1e882206af630b31","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-14T20:39:12.32933Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-14T20:39:12.329431Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-14T20:41:54.446105Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27670} {"level":"info","ts":"2026-10-14T20:41:54.573764Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27670,"took":"123.420476ms","hash":242988894,"current-db-size-bytes":56721408,"current-db-size":"57 MB","current-db-size-in-use-bytes":35692544,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-14T20:41:54.57382Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":242988894,"revision":27670,"compact-revision":24900} {"level":"info","ts":"2026-10-14T20:46:54.461646Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30308} {"level":"info","ts":"2026-10-14T20:46:54.606666Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30308,"took":"140.687788ms","hash":2445421644,"current-db-size-bytes":56721408,"current-db-size":"57 MB","current-db-size-in-use-bytes":30478336,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-14T20:46:54.606806Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2445421644,"revision":30308,"compact-revision":27670} {"level":"info","ts":"2026-10-14T20:51:54.474213Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32563} {"level":"info","ts":"2026-10-14T20:51:54.631497Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32563,"took":"153.018761ms","hash":974768445,"current-db-size-bytes":57765888,"current-db-size":"58 MB","current-db-size-in-use-bytes":30089216,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-14T20:51:54.631586Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":974768445,"revision":32563,"compact-revision":30308} {"level":"info","ts":"2026-10-14T20:56:54.485671Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34790} {"level":"info","ts":"2026-10-14T20:56:54.618866Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34790,"took":"128.477187ms","hash":3744855808,"current-db-size-bytes":57765888,"current-db-size":"58 MB","current-db-size-in-use-bytes":31801344,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-14T20:56:54.618947Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3744855808,"revision":34790,"compact-revision":32563} {"level":"info","ts":"2026-10-14T21:00:29.045858Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1e882206af630b31","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-14T21:00:29.052733Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-14T21:00:29.052913Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-14T21:01:54.492717Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37087} {"level":"info","ts":"2026-10-14T21:01:54.622212Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37087,"took":"125.245177ms","hash":1578969761,"current-db-size-bytes":57765888,"current-db-size":"58 MB","current-db-size-in-use-bytes":31899648,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-14T21:01:54.622261Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1578969761,"revision":37087,"compact-revision":34790} {"level":"info","ts":"2026-10-14T21:06:54.499511Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39423} {"level":"info","ts":"2026-10-14T21:06:54.638031Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39423,"took":"134.676215ms","hash":643299870,"current-db-size-bytes":57765888,"current-db-size":"58 MB","current-db-size-in-use-bytes":32137216,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-14T21:06:54.638103Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":643299870,"revision":39423,"compact-revision":37087}