{"level":"warn","ts":"2026-10-26T00:54:29.060242Z","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-26T00:54:29.060416Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.162:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.162:2380","--initial-cluster=instance=https://162.253.55.162:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.162:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.162: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-26T00:54:29.060524Z","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-26T00:54:29.060561Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.162:2380"]} {"level":"info","ts":"2026-10-26T00:54:29.060611Z","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-26T00:54:29.061669Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.162:2379"]} {"level":"info","ts":"2026-10-26T00:54:29.062036Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.162:2380"],"listen-peer-urls":["https://162.253.55.162:2380"],"advertise-client-urls":["https://162.253.55.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.162: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-26T00:54:29.065481Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.127386ms"} {"level":"info","ts":"2026-10-26T00:54:29.078101Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f61dce011a423b00","cluster-id":"d363ade277557413"} {"level":"info","ts":"2026-10-26T00:54:29.078256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f61dce011a423b00 switched to configuration voters=()"} {"level":"info","ts":"2026-10-26T00:54:29.078295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f61dce011a423b00 became follower at term 0"} {"level":"info","ts":"2026-10-26T00:54:29.078324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f61dce011a423b00 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-26T00:54:29.078346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f61dce011a423b00 became follower at term 1"} {"level":"info","ts":"2026-10-26T00:54:29.078397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f61dce011a423b00 switched to configuration voters=(17734557411785718528)"} {"level":"warn","ts":"2026-10-26T00:54:29.084076Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-26T00:54:29.08571Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-26T00:54:29.087318Z","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-26T00:54:29.089584Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f61dce011a423b00","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-26T00:54:29.089896Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f61dce011a423b00","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-26T00:54:29.089964Z","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-26T00:54:29.090619Z","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-26T00:54:29.090757Z","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-26T00:54:29.091972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f61dce011a423b00 switched to configuration voters=(17734557411785718528)"} {"level":"info","ts":"2026-10-26T00:54:29.092192Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d363ade277557413","local-member-id":"f61dce011a423b00","added-peer-id":"f61dce011a423b00","added-peer-peer-urls":["https://162.253.55.162:2380"]} {"level":"info","ts":"2026-10-26T00:54:29.095141Z","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-26T00:54:29.09529Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.162:2380"} {"level":"info","ts":"2026-10-26T00:54:29.095372Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.162:2380"} {"level":"info","ts":"2026-10-26T00:54:29.0956Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f61dce011a423b00","initial-advertise-peer-urls":["https://162.253.55.162:2380"],"listen-peer-urls":["https://162.253.55.162:2380"],"advertise-client-urls":["https://162.253.55.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-26T00:54:29.095684Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-26T00:54:29.479484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f61dce011a423b00 is starting a new election at term 1"} {"level":"info","ts":"2026-10-26T00:54:29.479568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f61dce011a423b00 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-26T00:54:29.479687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f61dce011a423b00 received MsgPreVoteResp from f61dce011a423b00 at term 1"} {"level":"info","ts":"2026-10-26T00:54:29.479713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f61dce011a423b00 became candidate at term 2"} {"level":"info","ts":"2026-10-26T00:54:29.47973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f61dce011a423b00 received MsgVoteResp from f61dce011a423b00 at term 2"} {"level":"info","ts":"2026-10-26T00:54:29.479748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f61dce011a423b00 became leader at term 2"} {"level":"info","ts":"2026-10-26T00:54:29.479778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f61dce011a423b00 elected leader f61dce011a423b00 at term 2"} {"level":"info","ts":"2026-10-26T00:54:29.481073Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T00:54:29.482045Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f61dce011a423b00","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.162:2379]}","request-path":"/0/members/f61dce011a423b00/attributes","cluster-id":"d363ade277557413","publish-timeout":"7s"} {"level":"info","ts":"2026-10-26T00:54:29.482235Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-26T00:54:29.482344Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-26T00:54:29.482828Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d363ade277557413","local-member-id":"f61dce011a423b00","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T00:54:29.483026Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T00:54:29.483088Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T00:54:29.485633Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.162:2379"} {"level":"info","ts":"2026-10-26T00:54:29.485761Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-26T00:54:29.486225Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-26T00:54:29.486271Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-26T00:54:45.331976Z","caller":"traceutil/trace.go:171","msg":"trace[1798081471] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"343.191893ms","start":"2026-10-26T00:54:44.988754Z","end":"2026-10-26T00:54:45.331946Z","steps":["trace[1798081471] 'process raft request' (duration: 342.958517ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:54:45.332522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:54:44.988734Z","time spent":"343.373948ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T00:55:21.588458Z","caller":"traceutil/trace.go:171","msg":"trace[1778601674] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"177.979579ms","start":"2026-10-26T00:55:21.410377Z","end":"2026-10-26T00:55:21.588357Z","steps":["trace[1778601674] 'process raft request' (duration: 177.240999ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:55:21.789435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.791174ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-26T00:55:21.789621Z","caller":"traceutil/trace.go:171","msg":"trace[162846305] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"127.588847ms","start":"2026-10-26T00:55:21.661997Z","end":"2026-10-26T00:55:21.789586Z","steps":["trace[162846305] 'process raft request' (duration: 25.32045ms)","trace[162846305] 'compare' (duration: 101.611889ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:55:22.245376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.26347ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T00:55:22.245544Z","caller":"traceutil/trace.go:171","msg":"trace[203639330] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:677; }","duration":"124.238364ms","start":"2026-10-26T00:55:22.121251Z","end":"2026-10-26T00:55:22.24549Z","steps":["trace[203639330] 'read index received' (duration: 55.061µs)","trace[203639330] 'applied index is now lower than readState.Index' (duration: 124.182053ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:55:22.245564Z","caller":"traceutil/trace.go:171","msg":"trace[31527379] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"436.127854ms","start":"2026-10-26T00:55:21.809392Z","end":"2026-10-26T00:55:22.24552Z","steps":["trace[31527379] 'process raft request' (duration: 271.604967ms)","trace[31527379] 'compare' (duration: 164.117786ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:55:22.245672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.421779ms","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-26T00:55:22.245724Z","caller":"traceutil/trace.go:171","msg":"trace[112516489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:651; }","duration":"124.518402ms","start":"2026-10-26T00:55:22.12119Z","end":"2026-10-26T00:55:22.245709Z","steps":["trace[112516489] 'agreement among raft nodes before linearized reading' (duration: 124.399278ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:55:22.245774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:55:21.809356Z","time spent":"436.308749ms","remote":"127.0.0.1:55216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T00:55:37.457696Z","caller":"traceutil/trace.go:171","msg":"trace[511772005] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"220.404051ms","start":"2026-10-26T00:55:37.23726Z","end":"2026-10-26T00:55:37.457664Z","steps":["trace[511772005] 'process raft request' (duration: 188.968512ms)","trace[511772005] 'compare' (duration: 31.302665ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:56:06.68549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.340303ms","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-26T00:56:06.685637Z","caller":"traceutil/trace.go:171","msg":"trace[1129194900] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1217; }","duration":"156.555118ms","start":"2026-10-26T00:56:06.529041Z","end":"2026-10-26T00:56:06.685596Z","steps":["trace[1129194900] 'range keys from in-memory index tree' (duration: 156.134857ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:56:56.483278Z","caller":"traceutil/trace.go:171","msg":"trace[1800257649] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"171.799751ms","start":"2026-10-26T00:56:56.311455Z","end":"2026-10-26T00:56:56.483254Z","steps":["trace[1800257649] 'process raft request' (duration: 171.661857ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:56:56.483339Z","caller":"traceutil/trace.go:171","msg":"trace[856182972] linearizableReadLoop","detail":"{readStateIndex:1980; appliedIndex:1980; }","duration":"170.31908ms","start":"2026-10-26T00:56:56.312996Z","end":"2026-10-26T00:56:56.483315Z","steps":["trace[856182972] 'read index received' (duration: 170.30949ms)","trace[856182972] 'applied index is now lower than readState.Index' (duration: 7.64µs)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:56:56.483572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.552566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5700"} {"level":"info","ts":"2026-10-26T00:56:56.483615Z","caller":"traceutil/trace.go:171","msg":"trace[987158774] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1904; }","duration":"170.628909ms","start":"2026-10-26T00:56:56.312973Z","end":"2026-10-26T00:56:56.483602Z","steps":["trace[987158774] 'agreement among raft nodes before linearized reading' (duration: 170.446884ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:56:56.758331Z","caller":"traceutil/trace.go:171","msg":"trace[1057843247] linearizableReadLoop","detail":"{readStateIndex:1981; appliedIndex:1980; }","duration":"274.904909ms","start":"2026-10-26T00:56:56.483399Z","end":"2026-10-26T00:56:56.758304Z","steps":["trace[1057843247] 'read index received' (duration: 236.774132ms)","trace[1057843247] 'applied index is now lower than readState.Index' (duration: 38.129487ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:56:56.758359Z","caller":"traceutil/trace.go:171","msg":"trace[1972704364] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"311.209235ms","start":"2026-10-26T00:56:56.447117Z","end":"2026-10-26T00:56:56.758326Z","steps":["trace[1972704364] 'process raft request' (duration: 273.036867ms)","trace[1972704364] 'compare' (duration: 37.865069ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T00:56:56.758528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:56:56.447092Z","time spent":"311.334869ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T00:56:56.758559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.585428ms","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-26T00:56:56.758589Z","caller":"traceutil/trace.go:171","msg":"trace[1715803879] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1905; }","duration":"428.624469ms","start":"2026-10-26T00:56:56.329955Z","end":"2026-10-26T00:56:56.758579Z","steps":["trace[1715803879] 'agreement among raft nodes before linearized reading' (duration: 428.479585ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:56:56.758622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T00:56:56.329896Z","time spent":"428.716492ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-26T00:56:56.758985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.182885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:11251"} {"level":"info","ts":"2026-10-26T00:56:56.759055Z","caller":"traceutil/trace.go:171","msg":"trace[2072471199] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1905; }","duration":"271.302559ms","start":"2026-10-26T00:56:56.487737Z","end":"2026-10-26T00:56:56.759039Z","steps":["trace[2072471199] 'agreement among raft nodes before linearized reading' (duration: 270.810925ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:56:56.969954Z","caller":"traceutil/trace.go:171","msg":"trace[1995483332] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"193.516053ms","start":"2026-10-26T00:56:56.776416Z","end":"2026-10-26T00:56:56.969932Z","steps":["trace[1995483332] 'process raft request' (duration: 193.291267ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:56:56.970108Z","caller":"traceutil/trace.go:171","msg":"trace[1276244348] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"203.018346ms","start":"2026-10-26T00:56:56.767062Z","end":"2026-10-26T00:56:56.97008Z","steps":["trace[1276244348] 'process raft request' (duration: 202.478261ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:56:57.256487Z","caller":"traceutil/trace.go:171","msg":"trace[537892956] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"279.145276ms","start":"2026-10-26T00:56:56.977302Z","end":"2026-10-26T00:56:57.256447Z","steps":["trace[537892956] 'process raft request' (duration: 278.833247ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:56:57.256513Z","caller":"traceutil/trace.go:171","msg":"trace[1968755751] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"279.000062ms","start":"2026-10-26T00:56:56.977487Z","end":"2026-10-26T00:56:57.256487Z","steps":["trace[1968755751] 'process raft request' (duration: 278.803376ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:56:57.256568Z","caller":"traceutil/trace.go:171","msg":"trace[171994646] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"278.122798ms","start":"2026-10-26T00:56:56.978417Z","end":"2026-10-26T00:56:57.256539Z","steps":["trace[171994646] 'process raft request' (duration: 277.926163ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:56:57.256664Z","caller":"traceutil/trace.go:171","msg":"trace[1293058365] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"278.066007ms","start":"2026-10-26T00:56:56.97852Z","end":"2026-10-26T00:56:57.256586Z","steps":["trace[1293058365] 'process raft request' (duration: 277.967064ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:56:57.330532Z","caller":"traceutil/trace.go:171","msg":"trace[1723800493] linearizableReadLoop","detail":"{readStateIndex:1990; appliedIndex:1985; }","duration":"114.419141ms","start":"2026-10-26T00:56:57.216091Z","end":"2026-10-26T00:56:57.33051Z","steps":["trace[1723800493] 'read index received' (duration: 40.113282ms)","trace[1723800493] 'applied index is now lower than readState.Index' (duration: 74.304759ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:56:57.330596Z","caller":"traceutil/trace.go:171","msg":"trace[954053223] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"140.705789ms","start":"2026-10-26T00:56:57.189861Z","end":"2026-10-26T00:56:57.330567Z","steps":["trace[954053223] 'process raft request' (duration: 131.0094ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:56:57.330787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.683318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-26T00:56:57.33087Z","caller":"traceutil/trace.go:171","msg":"trace[697258399] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1914; }","duration":"114.812962ms","start":"2026-10-26T00:56:57.21604Z","end":"2026-10-26T00:56:57.330853Z","steps":["trace[697258399] 'agreement among raft nodes before linearized reading' (duration: 114.603896ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T00:57:51.416691Z","caller":"traceutil/trace.go:171","msg":"trace[2063238516] linearizableReadLoop","detail":"{readStateIndex:2343; appliedIndex:2342; }","duration":"128.490982ms","start":"2026-10-26T00:57:51.288176Z","end":"2026-10-26T00:57:51.416667Z","steps":["trace[2063238516] 'read index received' (duration: 128.174634ms)","trace[2063238516] 'applied index is now lower than readState.Index' (duration: 315.298µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T00:57:51.416743Z","caller":"traceutil/trace.go:171","msg":"trace[1234554376] transaction","detail":"{read_only:false; response_revision:2255; number_of_response:1; }","duration":"130.911359ms","start":"2026-10-26T00:57:51.285805Z","end":"2026-10-26T00:57:51.416716Z","steps":["trace[1234554376] 'process raft request' (duration: 130.698953ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:57:51.417009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.813501ms","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-26T00:57:51.417106Z","caller":"traceutil/trace.go:171","msg":"trace[798459428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2255; }","duration":"128.941374ms","start":"2026-10-26T00:57:51.288149Z","end":"2026-10-26T00:57:51.41709Z","steps":["trace[798459428] 'agreement among raft nodes before linearized reading' (duration: 128.713678ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T00:57:51.986067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.63013ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T00:57:51.986261Z","caller":"traceutil/trace.go:171","msg":"trace[1232731175] transaction","detail":"{read_only:false; response_revision:2258; number_of_response:1; }","duration":"175.910214ms","start":"2026-10-26T00:57:51.810292Z","end":"2026-10-26T00:57:51.986202Z","steps":["trace[1232731175] 'process raft request' (duration: 36.031697ms)","trace[1232731175] 'compare' (duration: 139.433824ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:02:13.34448Z","caller":"traceutil/trace.go:171","msg":"trace[1387805345] transaction","detail":"{read_only:false; response_revision:4048; number_of_response:1; }","duration":"141.28033ms","start":"2026-10-26T01:02:13.203139Z","end":"2026-10-26T01:02:13.344419Z","steps":["trace[1387805345] 'process raft request' (duration: 140.91249ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:04:19.621337Z","caller":"traceutil/trace.go:171","msg":"trace[1376811725] linearizableReadLoop","detail":"{readStateIndex:6056; appliedIndex:6055; }","duration":"227.119459ms","start":"2026-10-26T01:04:19.394194Z","end":"2026-10-26T01:04:19.621313Z","steps":["trace[1376811725] 'read index received' (duration: 226.905973ms)","trace[1376811725] 'applied index is now lower than readState.Index' (duration: 212.636µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:04:19.621396Z","caller":"traceutil/trace.go:171","msg":"trace[2063748673] transaction","detail":"{read_only:false; response_revision:5837; number_of_response:1; }","duration":"248.711864ms","start":"2026-10-26T01:04:19.372646Z","end":"2026-10-26T01:04:19.621358Z","steps":["trace[2063748673] 'process raft request' (duration: 248.502778ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:04:19.621628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.430708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-pkr97\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-10-26T01:04:19.621663Z","caller":"traceutil/trace.go:171","msg":"trace[1152781320] range","detail":"{range_begin:/registry/pods/openstack/keepalived-pkr97; range_end:; response_count:1; response_revision:5837; }","duration":"227.555981ms","start":"2026-10-26T01:04:19.394096Z","end":"2026-10-26T01:04:19.621652Z","steps":["trace[1152781320] 'agreement among raft nodes before linearized reading' (duration: 227.340975ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:04:19.621954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.08399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-26T01:04:19.62198Z","caller":"traceutil/trace.go:171","msg":"trace[426236564] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5837; }","duration":"222.130681ms","start":"2026-10-26T01:04:19.399841Z","end":"2026-10-26T01:04:19.621972Z","steps":["trace[426236564] 'agreement among raft nodes before linearized reading' (duration: 222.032758ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:04:19.622088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.103618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T01:04:19.62211Z","caller":"traceutil/trace.go:171","msg":"trace[1869275045] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:5837; }","duration":"219.159329ms","start":"2026-10-26T01:04:19.402944Z","end":"2026-10-26T01:04:19.622103Z","steps":["trace[1869275045] 'agreement among raft nodes before linearized reading' (duration: 219.118208ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:04:19.6222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.85416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-pushgateway-7b8659c68b-rnjcj\" ","response":"range_response_count:1 size:4344"} {"level":"info","ts":"2026-10-26T01:04:19.622264Z","caller":"traceutil/trace.go:171","msg":"trace[332092303] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-pushgateway-7b8659c68b-rnjcj; range_end:; response_count:1; response_revision:5837; }","duration":"131.977743ms","start":"2026-10-26T01:04:19.490269Z","end":"2026-10-26T01:04:19.622247Z","steps":["trace[332092303] 'agreement among raft nodes before linearized reading' (duration: 131.748536ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:04:19.622428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.565781ms","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-26T01:04:19.622517Z","caller":"traceutil/trace.go:171","msg":"trace[1678464744] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5837; }","duration":"219.708545ms","start":"2026-10-26T01:04:19.402789Z","end":"2026-10-26T01:04:19.622497Z","steps":["trace[1678464744] 'agreement among raft nodes before linearized reading' (duration: 219.442437ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:04:19.741438Z","caller":"traceutil/trace.go:171","msg":"trace[1717732101] transaction","detail":"{read_only:false; response_revision:5838; number_of_response:1; }","duration":"114.0966ms","start":"2026-10-26T01:04:19.627314Z","end":"2026-10-26T01:04:19.74141Z","steps":["trace[1717732101] 'process raft request' (duration: 60.333466ms)","trace[1717732101] 'compare' (duration: 53.602599ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:04:19.747876Z","caller":"traceutil/trace.go:171","msg":"trace[746755561] transaction","detail":"{read_only:false; response_revision:5840; number_of_response:1; }","duration":"115.114268ms","start":"2026-10-26T01:04:19.632742Z","end":"2026-10-26T01:04:19.747856Z","steps":["trace[746755561] 'process raft request' (duration: 115.022905ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:04:19.747906Z","caller":"traceutil/trace.go:171","msg":"trace[1206800074] transaction","detail":"{read_only:false; response_revision:5839; number_of_response:1; }","duration":"118.09291ms","start":"2026-10-26T01:04:19.629766Z","end":"2026-10-26T01:04:19.747859Z","steps":["trace[1206800074] 'process raft request' (duration: 117.884964ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:04:20.115319Z","caller":"traceutil/trace.go:171","msg":"trace[1085204108] transaction","detail":"{read_only:false; response_revision:5850; number_of_response:1; }","duration":"139.864451ms","start":"2026-10-26T01:04:19.975433Z","end":"2026-10-26T01:04:20.115297Z","steps":["trace[1085204108] 'process raft request' (duration: 61.983141ms)","trace[1085204108] 'compare' (duration: 77.699395ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:04:20.115408Z","caller":"traceutil/trace.go:171","msg":"trace[1956364687] transaction","detail":"{read_only:false; response_revision:5851; number_of_response:1; }","duration":"125.507004ms","start":"2026-10-26T01:04:19.989873Z","end":"2026-10-26T01:04:20.11538Z","steps":["trace[1956364687] 'process raft request' (duration: 125.37558ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:04:20.115326Z","caller":"traceutil/trace.go:171","msg":"trace[1070530281] linearizableReadLoop","detail":"{readStateIndex:6069; appliedIndex:6068; }","duration":"130.836922ms","start":"2026-10-26T01:04:19.984464Z","end":"2026-10-26T01:04:20.115301Z","steps":["trace[1070530281] 'read index received' (duration: 52.964252ms)","trace[1070530281] 'applied index is now lower than readState.Index' (duration: 77.87016ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T01:04:20.115527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.041817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9785"} {"level":"info","ts":"2026-10-26T01:04:20.11558Z","caller":"traceutil/trace.go:171","msg":"trace[547480061] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:5851; }","duration":"131.125899ms","start":"2026-10-26T01:04:19.984441Z","end":"2026-10-26T01:04:20.115567Z","steps":["trace[547480061] 'agreement among raft nodes before linearized reading' (duration: 130.937404ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:04:29.573567Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2986} {"level":"info","ts":"2026-10-26T01:04:29.669123Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2986,"took":"94.089046ms","hash":1085970316,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":32632832,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-26T01:04:29.669188Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1085970316,"revision":2986,"compact-revision":-1} {"level":"info","ts":"2026-10-26T01:09:29.580343Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5910} {"level":"info","ts":"2026-10-26T01:09:29.66542Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5910,"took":"83.02038ms","hash":2156655591,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":25886720,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-26T01:09:29.665483Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2156655591,"revision":5910,"compact-revision":2986} {"level":"info","ts":"2026-10-26T01:10:39.52033Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000022fb.wal"} {"level":"info","ts":"2026-10-26T01:10:41.382146Z","caller":"traceutil/trace.go:171","msg":"trace[1025713460] transaction","detail":"{read_only:false; response_revision:8652; number_of_response:1; }","duration":"273.588151ms","start":"2026-10-26T01:10:41.108534Z","end":"2026-10-26T01:10:41.382122Z","steps":["trace[1025713460] 'process raft request' (duration: 273.432317ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:10:41.545646Z","caller":"traceutil/trace.go:171","msg":"trace[225524083] linearizableReadLoop","detail":"{readStateIndex:8963; appliedIndex:8962; }","duration":"214.028789ms","start":"2026-10-26T01:10:41.331599Z","end":"2026-10-26T01:10:41.545628Z","steps":["trace[225524083] 'read index received' (duration: 50.510182ms)","trace[225524083] 'applied index is now lower than readState.Index' (duration: 163.514527ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:10:41.54592Z","caller":"traceutil/trace.go:171","msg":"trace[1575683713] transaction","detail":"{read_only:false; response_revision:8653; number_of_response:1; }","duration":"386.164904ms","start":"2026-10-26T01:10:41.159741Z","end":"2026-10-26T01:10:41.545906Z","steps":["trace[1575683713] 'process raft request' (duration: 344.243668ms)","trace[1575683713] 'compare' (duration: 41.171565ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T01:10:41.54603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:10:41.159707Z","time spent":"386.246736ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T01:10:41.546029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.41056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T01:10:41.546033Z","caller":"traceutil/trace.go:171","msg":"trace[673843612] transaction","detail":"{read_only:false; response_revision:8654; number_of_response:1; }","duration":"183.667032ms","start":"2026-10-26T01:10:41.362325Z","end":"2026-10-26T01:10:41.545992Z","steps":["trace[673843612] 'process raft request' (duration: 183.245ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:10:41.546106Z","caller":"traceutil/trace.go:171","msg":"trace[1499176352] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:8654; }","duration":"214.544164ms","start":"2026-10-26T01:10:41.331542Z","end":"2026-10-26T01:10:41.546086Z","steps":["trace[1499176352] 'agreement among raft nodes before linearized reading' (duration: 214.3981ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:10:41.551995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.52505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-26T01:10:41.552073Z","caller":"traceutil/trace.go:171","msg":"trace[1018700469] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:8655; }","duration":"162.621702ms","start":"2026-10-26T01:10:41.389434Z","end":"2026-10-26T01:10:41.552056Z","steps":["trace[1018700469] 'agreement among raft nodes before linearized reading' (duration: 162.440377ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:10:51.930765Z","caller":"traceutil/trace.go:171","msg":"trace[802823669] transaction","detail":"{read_only:false; response_revision:8705; number_of_response:1; }","duration":"351.205351ms","start":"2026-10-26T01:10:51.579538Z","end":"2026-10-26T01:10:51.930743Z","steps":["trace[802823669] 'process raft request' (duration: 351.049116ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:10:51.930955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:10:51.579512Z","time spent":"351.355605ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T01:10:51.940353Z","caller":"traceutil/trace.go:171","msg":"trace[1956801350] transaction","detail":"{read_only:false; response_revision:8706; number_of_response:1; }","duration":"357.266308ms","start":"2026-10-26T01:10:51.58307Z","end":"2026-10-26T01:10:51.940336Z","steps":["trace[1956801350] 'process raft request' (duration: 357.016181ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:10:51.940336Z","caller":"traceutil/trace.go:171","msg":"trace[339287303] transaction","detail":"{read_only:false; response_revision:8707; number_of_response:1; }","duration":"354.894152ms","start":"2026-10-26T01:10:51.585417Z","end":"2026-10-26T01:10:51.940311Z","steps":["trace[339287303] 'process raft request' (duration: 354.8054ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:10:51.940464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:10:51.583045Z","time spent":"357.379031ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T01:10:51.940445Z","caller":"traceutil/trace.go:171","msg":"trace[160029646] linearizableReadLoop","detail":"{readStateIndex:9018; appliedIndex:9016; }","duration":"355.695994ms","start":"2026-10-26T01:10:51.584734Z","end":"2026-10-26T01:10:51.94043Z","steps":["trace[160029646] 'read index received' (duration: 345.871044ms)","trace[160029646] 'applied index is now lower than readState.Index' (duration: 9.82435ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T01:10:51.940548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.811138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-26T01:10:51.940617Z","caller":"traceutil/trace.go:171","msg":"trace[2082363434] transaction","detail":"{read_only:false; response_revision:8708; number_of_response:1; }","duration":"351.665573ms","start":"2026-10-26T01:10:51.588859Z","end":"2026-10-26T01:10:51.940525Z","steps":["trace[2082363434] 'process raft request' (duration: 351.411476ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:10:51.94071Z","caller":"traceutil/trace.go:171","msg":"trace[1227015380] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:8709; }","duration":"356.015784ms","start":"2026-10-26T01:10:51.584681Z","end":"2026-10-26T01:10:51.940697Z","steps":["trace[1227015380] 'agreement among raft nodes before linearized reading' (duration: 355.807038ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:10:51.940713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.603836ms","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-26T01:10:51.940753Z","caller":"traceutil/trace.go:171","msg":"trace[701562695] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8709; }","duration":"140.683278ms","start":"2026-10-26T01:10:51.800059Z","end":"2026-10-26T01:10:51.940742Z","steps":["trace[701562695] 'agreement among raft nodes before linearized reading' (duration: 140.562875ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:10:51.940759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.344018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-10-26T01:10:51.94077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:10:51.584661Z","time spent":"356.091545ms","remote":"127.0.0.1:55444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-10-26T01:10:51.940833Z","caller":"traceutil/trace.go:171","msg":"trace[1366013752] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8709; }","duration":"251.455481ms","start":"2026-10-26T01:10:51.68936Z","end":"2026-10-26T01:10:51.940816Z","steps":["trace[1366013752] 'agreement among raft nodes before linearized reading' (duration: 251.263536ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:10:51.940913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.149914ms","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-26T01:10:51.940894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:10:51.588842Z","time spent":"351.90899ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T01:10:51.940942Z","caller":"traceutil/trace.go:171","msg":"trace[264746934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8709; }","duration":"197.213446ms","start":"2026-10-26T01:10:51.743718Z","end":"2026-10-26T01:10:51.940931Z","steps":["trace[264746934] 'agreement among raft nodes before linearized reading' (duration: 197.137234ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:10:51.940931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.553117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-26T01:10:51.941007Z","caller":"traceutil/trace.go:171","msg":"trace[1935394931] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:8709; }","duration":"172.698911ms","start":"2026-10-26T01:10:51.768288Z","end":"2026-10-26T01:10:51.940986Z","steps":["trace[1935394931] 'agreement among raft nodes before linearized reading' (duration: 172.457434ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:10:51.94134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:10:51.585402Z","time spent":"355.044057ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T01:10:52.605178Z","caller":"traceutil/trace.go:171","msg":"trace[1518267102] transaction","detail":"{read_only:false; response_revision:8713; number_of_response:1; }","duration":"116.44122ms","start":"2026-10-26T01:10:52.488695Z","end":"2026-10-26T01:10:52.605136Z","steps":["trace[1518267102] 'process raft request' (duration: 116.197143ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:11:20.596645Z","caller":"traceutil/trace.go:171","msg":"trace[760791011] linearizableReadLoop","detail":"{readStateIndex:9237; appliedIndex:9236; }","duration":"120.489091ms","start":"2026-10-26T01:11:20.476137Z","end":"2026-10-26T01:11:20.596626Z","steps":["trace[760791011] 'read index received' (duration: 120.276905ms)","trace[760791011] 'applied index is now lower than readState.Index' (duration: 211.386µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:11:20.59674Z","caller":"traceutil/trace.go:171","msg":"trace[2113861707] transaction","detail":"{read_only:false; response_revision:8917; number_of_response:1; }","duration":"268.302836ms","start":"2026-10-26T01:11:20.328407Z","end":"2026-10-26T01:11:20.596709Z","steps":["trace[2113861707] 'process raft request' (duration: 268.09262ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:11:20.596829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.672586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12432"} {"level":"info","ts":"2026-10-26T01:11:20.596861Z","caller":"traceutil/trace.go:171","msg":"trace[49786913] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8917; }","duration":"120.756718ms","start":"2026-10-26T01:11:20.476095Z","end":"2026-10-26T01:11:20.596852Z","steps":["trace[49786913] 'agreement among raft nodes before linearized reading' (duration: 120.614415ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:11:20.801808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.535033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T01:11:20.801866Z","caller":"traceutil/trace.go:171","msg":"trace[1517276314] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8917; }","duration":"140.631276ms","start":"2026-10-26T01:11:20.661221Z","end":"2026-10-26T01:11:20.801852Z","steps":["trace[1517276314] 'range keys from in-memory index tree' (duration: 140.413251ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:11:33.031433Z","caller":"traceutil/trace.go:171","msg":"trace[859546695] linearizableReadLoop","detail":"{readStateIndex:9304; appliedIndex:9303; }","duration":"156.563704ms","start":"2026-10-26T01:11:32.874848Z","end":"2026-10-26T01:11:33.031412Z","steps":["trace[859546695] 'read index received' (duration: 156.497583ms)","trace[859546695] 'applied index is now lower than readState.Index' (duration: 65.001µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:11:33.031561Z","caller":"traceutil/trace.go:171","msg":"trace[1751895652] transaction","detail":"{read_only:false; response_revision:8981; number_of_response:1; }","duration":"163.99792ms","start":"2026-10-26T01:11:32.867535Z","end":"2026-10-26T01:11:33.031533Z","steps":["trace[1751895652] 'process raft request' (duration: 163.741303ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:11:33.031678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.821942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.162\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-26T01:11:33.031737Z","caller":"traceutil/trace.go:171","msg":"trace[1166858228] range","detail":"{range_begin:/registry/masterleases/162.253.55.162; range_end:; response_count:1; response_revision:8981; }","duration":"156.973396ms","start":"2026-10-26T01:11:32.874751Z","end":"2026-10-26T01:11:33.031725Z","steps":["trace[1166858228] 'agreement among raft nodes before linearized reading' (duration: 156.786781ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:11:33.031928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.704148ms","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-26T01:11:33.032008Z","caller":"traceutil/trace.go:171","msg":"trace[776021348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8981; }","duration":"148.829011ms","start":"2026-10-26T01:11:32.883162Z","end":"2026-10-26T01:11:33.031991Z","steps":["trace[776021348] 'agreement among raft nodes before linearized reading' (duration: 148.477732ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:11:33.156235Z","caller":"traceutil/trace.go:171","msg":"trace[1786350853] transaction","detail":"{read_only:false; response_revision:8982; number_of_response:1; }","duration":"119.866834ms","start":"2026-10-26T01:11:33.036332Z","end":"2026-10-26T01:11:33.156199Z","steps":["trace[1786350853] 'process raft request' (duration: 119.72635ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:12:36.698432Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f61dce011a423b00","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-26T01:12:36.704283Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-26T01:12:36.704379Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-26T01:13:04.821127Z","caller":"traceutil/trace.go:171","msg":"trace[522684186] transaction","detail":"{read_only:false; response_revision:9851; number_of_response:1; }","duration":"217.529845ms","start":"2026-10-26T01:13:04.603575Z","end":"2026-10-26T01:13:04.821105Z","steps":["trace[522684186] 'process raft request' (duration: 154.087787ms)","trace[522684186] 'compare' (duration: 63.309325ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:13:04.821506Z","caller":"traceutil/trace.go:171","msg":"trace[238136154] transaction","detail":"{read_only:false; response_revision:9852; number_of_response:1; }","duration":"214.147322ms","start":"2026-10-26T01:13:04.607313Z","end":"2026-10-26T01:13:04.821461Z","steps":["trace[238136154] 'process raft request' (duration: 213.760072ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:13:04.821551Z","caller":"traceutil/trace.go:171","msg":"trace[319466008] transaction","detail":"{read_only:false; response_revision:9854; number_of_response:1; }","duration":"159.785244ms","start":"2026-10-26T01:13:04.661744Z","end":"2026-10-26T01:13:04.821529Z","steps":["trace[319466008] 'process raft request' (duration: 159.711152ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:13:04.821616Z","caller":"traceutil/trace.go:171","msg":"trace[747149726] transaction","detail":"{read_only:false; response_revision:9853; number_of_response:1; }","duration":"181.668517ms","start":"2026-10-26T01:13:04.639898Z","end":"2026-10-26T01:13:04.821567Z","steps":["trace[747149726] 'process raft request' (duration: 181.434811ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:14:29.5893Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8046} {"level":"info","ts":"2026-10-26T01:14:29.659222Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8046,"took":"67.811398ms","hash":1151021354,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":28012544,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-26T01:14:29.659288Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1151021354,"revision":8046,"compact-revision":5910} {"level":"info","ts":"2026-10-26T01:18:26.212833Z","caller":"traceutil/trace.go:171","msg":"trace[650839794] transaction","detail":"{read_only:false; response_revision:12186; number_of_response:1; }","duration":"146.691571ms","start":"2026-10-26T01:18:26.066107Z","end":"2026-10-26T01:18:26.212798Z","steps":["trace[650839794] 'process raft request' (duration: 134.636899ms)","trace[650839794] 'compare' (duration: 11.149277ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:18:26.212889Z","caller":"traceutil/trace.go:171","msg":"trace[2089512630] transaction","detail":"{read_only:false; response_revision:12187; number_of_response:1; }","duration":"144.819849ms","start":"2026-10-26T01:18:26.068019Z","end":"2026-10-26T01:18:26.212839Z","steps":["trace[2089512630] 'process raft request' (duration: 144.336236ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:18:46.872806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.943727ms","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:2082"} {"level":"info","ts":"2026-10-26T01:18:46.8729Z","caller":"traceutil/trace.go:171","msg":"trace[807396577] 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:12304; }","duration":"179.098262ms","start":"2026-10-26T01:18:46.693777Z","end":"2026-10-26T01:18:46.872875Z","steps":["trace[807396577] 'range keys from in-memory index tree' (duration: 178.754692ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:18:46.872912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.179108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-26T01:18:46.873035Z","caller":"traceutil/trace.go:171","msg":"trace[1297329163] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:12304; }","duration":"141.330042ms","start":"2026-10-26T01:18:46.731676Z","end":"2026-10-26T01:18:46.873006Z","steps":["trace[1297329163] 'range keys from in-memory index tree' (duration: 141.020743ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:18:46.873433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.823555ms","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-26T01:18:46.873562Z","caller":"traceutil/trace.go:171","msg":"trace[791336248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12304; }","duration":"134.0108ms","start":"2026-10-26T01:18:46.73952Z","end":"2026-10-26T01:18:46.873531Z","steps":["trace[791336248] 'range keys from in-memory index tree' (duration: 133.260369ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:18:47.053516Z","caller":"traceutil/trace.go:171","msg":"trace[1426426598] transaction","detail":"{read_only:false; response_revision:12306; number_of_response:1; }","duration":"175.432331ms","start":"2026-10-26T01:18:46.878055Z","end":"2026-10-26T01:18:47.053487Z","steps":["trace[1426426598] 'process raft request' (duration: 175.259436ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:19:29.5964Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10434} {"level":"info","ts":"2026-10-26T01:19:29.687409Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10434,"took":"87.50854ms","hash":274125787,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":25677824,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-26T01:19:29.687499Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":274125787,"revision":10434,"compact-revision":8046} {"level":"info","ts":"2026-10-26T01:24:29.605714Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12609} {"level":"info","ts":"2026-10-26T01:24:29.694073Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12609,"took":"85.342568ms","hash":3901482793,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":27885568,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-26T01:24:29.694222Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3901482793,"revision":12609,"compact-revision":10434} {"level":"info","ts":"2026-10-26T01:25:37.159096Z","caller":"traceutil/trace.go:171","msg":"trace[1956091780] transaction","detail":"{read_only:false; response_revision:15021; number_of_response:1; }","duration":"131.054719ms","start":"2026-10-26T01:25:37.028014Z","end":"2026-10-26T01:25:37.159068Z","steps":["trace[1956091780] 'process raft request' (duration: 130.839313ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:25:37.874944Z","caller":"traceutil/trace.go:171","msg":"trace[1425985692] transaction","detail":"{read_only:false; response_revision:15024; number_of_response:1; }","duration":"259.356629ms","start":"2026-10-26T01:25:37.615555Z","end":"2026-10-26T01:25:37.874912Z","steps":["trace[1425985692] 'process raft request' (duration: 259.191465ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:25:38.032839Z","caller":"traceutil/trace.go:171","msg":"trace[701253619] transaction","detail":"{read_only:false; response_revision:15028; number_of_response:1; }","duration":"113.295539ms","start":"2026-10-26T01:25:37.919508Z","end":"2026-10-26T01:25:38.032803Z","steps":["trace[701253619] 'process raft request' (duration: 113.239487ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:25:38.032901Z","caller":"traceutil/trace.go:171","msg":"trace[2127383119] linearizableReadLoop","detail":"{readStateIndex:15552; appliedIndex:15549; }","duration":"254.25687ms","start":"2026-10-26T01:25:37.778618Z","end":"2026-10-26T01:25:38.032875Z","steps":["trace[2127383119] 'read index received' (duration: 96.151657ms)","trace[2127383119] 'applied index is now lower than readState.Index' (duration: 158.103403ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:25:38.033064Z","caller":"traceutil/trace.go:171","msg":"trace[1595869767] transaction","detail":"{read_only:false; response_revision:15027; number_of_response:1; }","duration":"153.030043ms","start":"2026-10-26T01:25:37.880019Z","end":"2026-10-26T01:25:38.033049Z","steps":["trace[1595869767] 'process raft request' (duration: 152.670723ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:25:38.033083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.442825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T01:25:38.03312Z","caller":"traceutil/trace.go:171","msg":"trace[987597146] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:15028; }","duration":"254.545607ms","start":"2026-10-26T01:25:37.778563Z","end":"2026-10-26T01:25:38.033108Z","steps":["trace[987597146] 'agreement among raft nodes before linearized reading' (duration: 254.437564ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:25:38.032843Z","caller":"traceutil/trace.go:171","msg":"trace[179137958] transaction","detail":"{read_only:false; response_revision:15026; number_of_response:1; }","duration":"254.923788ms","start":"2026-10-26T01:25:37.777884Z","end":"2026-10-26T01:25:38.032807Z","steps":["trace[179137958] 'process raft request' (duration: 254.683021ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:25:38.033231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.873514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T01:25:38.033271Z","caller":"traceutil/trace.go:171","msg":"trace[1197076639] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:15028; }","duration":"170.965457ms","start":"2026-10-26T01:25:37.862294Z","end":"2026-10-26T01:25:38.033259Z","steps":["trace[1197076639] 'agreement among raft nodes before linearized reading' (duration: 170.901035ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:25:38.032924Z","caller":"traceutil/trace.go:171","msg":"trace[727470569] transaction","detail":"{read_only:false; response_revision:15025; number_of_response:1; }","duration":"417.303268ms","start":"2026-10-26T01:25:37.615605Z","end":"2026-10-26T01:25:38.032908Z","steps":["trace[727470569] 'process raft request' (duration: 371.157108ms)","trace[727470569] 'compare' (duration: 45.43819ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T01:25:38.033428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:25:37.615579Z","time spent":"417.74061ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T01:25:38.03348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.93188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-5jf9z\" ","response":"range_response_count:1 size:12364"} {"level":"info","ts":"2026-10-26T01:25:38.033501Z","caller":"traceutil/trace.go:171","msg":"trace[759204978] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-5jf9z; range_end:; response_count:1; response_revision:15028; }","duration":"157.022763ms","start":"2026-10-26T01:25:37.876472Z","end":"2026-10-26T01:25:38.033495Z","steps":["trace[759204978] 'agreement among raft nodes before linearized reading' (duration: 156.90396ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:26:02.928841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.093724ms","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-26T01:26:02.92896Z","caller":"traceutil/trace.go:171","msg":"trace[1051062270] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15348; }","duration":"121.283759ms","start":"2026-10-26T01:26:02.807648Z","end":"2026-10-26T01:26:02.928931Z","steps":["trace[1051062270] 'range keys from in-memory index tree' (duration: 120.841796ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:26:02.929163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.783025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a501593e-d989-4771-857c-58607842ce32\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-10-26T01:26:02.929241Z","caller":"traceutil/trace.go:171","msg":"trace[2035339669] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a501593e-d989-4771-857c-58607842ce32; range_end:; response_count:1; response_revision:15348; }","duration":"120.928549ms","start":"2026-10-26T01:26:02.80829Z","end":"2026-10-26T01:26:02.929219Z","steps":["trace[2035339669] 'range keys from in-memory index tree' (duration: 120.160268ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:26:03.243547Z","caller":"traceutil/trace.go:171","msg":"trace[42372676] linearizableReadLoop","detail":"{readStateIndex:15890; appliedIndex:15888; }","duration":"159.743098ms","start":"2026-10-26T01:26:03.083746Z","end":"2026-10-26T01:26:03.243489Z","steps":["trace[42372676] 'read index received' (duration: 124.21149ms)","trace[42372676] 'applied index is now lower than readState.Index' (duration: 35.530178ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:26:03.243588Z","caller":"traceutil/trace.go:171","msg":"trace[1459480847] transaction","detail":"{read_only:false; response_revision:15349; number_of_response:1; }","duration":"307.98844ms","start":"2026-10-26T01:26:02.935557Z","end":"2026-10-26T01:26:03.243545Z","steps":["trace[1459480847] 'process raft request' (duration: 297.167662ms)","trace[1459480847] 'compare' (duration: 10.491968ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T01:26:03.243837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:26:02.935536Z","time spent":"308.160855ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T01:26:03.244049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.228521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-26T01:26:03.244196Z","caller":"traceutil/trace.go:171","msg":"trace[1699118285] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:15350; }","duration":"160.495389ms","start":"2026-10-26T01:26:03.08367Z","end":"2026-10-26T01:26:03.244165Z","steps":["trace[1699118285] 'agreement among raft nodes before linearized reading' (duration: 159.980514ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:26:58.105343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.87353ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-26T01:26:58.105911Z","caller":"traceutil/trace.go:171","msg":"trace[953667384] transaction","detail":"{read_only:false; response_revision:15993; number_of_response:1; }","duration":"140.097437ms","start":"2026-10-26T01:26:57.965779Z","end":"2026-10-26T01:26:58.105877Z","steps":["trace[953667384] 'process raft request' (duration: 139.753758ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:29:29.613667Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14597} {"level":"info","ts":"2026-10-26T01:29:29.69284Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14597,"took":"77.020061ms","hash":4286454787,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":31043584,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-26T01:29:29.692912Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4286454787,"revision":14597,"compact-revision":12609} {"level":"warn","ts":"2026-10-26T01:33:54.285195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.899829ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-26T01:33:54.285429Z","caller":"traceutil/trace.go:171","msg":"trace[1781714202] transaction","detail":"{read_only:false; response_revision:18935; number_of_response:1; }","duration":"225.180932ms","start":"2026-10-26T01:33:54.060229Z","end":"2026-10-26T01:33:54.28541Z","steps":["trace[1781714202] 'process raft request' (duration: 225.138141ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:33:54.285739Z","caller":"traceutil/trace.go:171","msg":"trace[298497655] transaction","detail":"{read_only:false; response_revision:18934; number_of_response:1; }","duration":"287.517571ms","start":"2026-10-26T01:33:53.998208Z","end":"2026-10-26T01:33:54.285725Z","steps":["trace[298497655] 'process raft request' (duration: 287.096969ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:33:54.285404Z","caller":"traceutil/trace.go:171","msg":"trace[924855538] linearizableReadLoop","detail":"{readStateIndex:19589; appliedIndex:19588; }","duration":"362.673451ms","start":"2026-10-26T01:33:53.922691Z","end":"2026-10-26T01:33:54.285365Z","steps":["trace[924855538] 'read index received' (duration: 189.499944ms)","trace[924855538] 'applied index is now lower than readState.Index' (duration: 173.171617ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:33:54.286081Z","caller":"traceutil/trace.go:171","msg":"trace[1247202044] transaction","detail":"{read_only:false; response_revision:18933; number_of_response:1; }","duration":"430.269473ms","start":"2026-10-26T01:33:53.855763Z","end":"2026-10-26T01:33:54.286033Z","steps":["trace[1247202044] 'process raft request' (duration: 256.418378ms)","trace[1247202044] 'compare' (duration: 172.787436ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T01:33:54.286153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.168984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-10-26T01:33:54.286202Z","caller":"traceutil/trace.go:171","msg":"trace[1779596523] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18935; }","duration":"363.538214ms","start":"2026-10-26T01:33:53.922651Z","end":"2026-10-26T01:33:54.286189Z","steps":["trace[1779596523] 'agreement among raft nodes before linearized reading' (duration: 362.829025ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:33:54.286244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:33:53.922629Z","time spent":"363.606166ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-26T01:33:54.286257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:33:53.855739Z","time spent":"430.428038ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T01:33:54.339119Z","caller":"traceutil/trace.go:171","msg":"trace[563770717] transaction","detail":"{read_only:false; response_revision:18936; number_of_response:1; }","duration":"171.009247ms","start":"2026-10-26T01:33:54.168085Z","end":"2026-10-26T01:33:54.339095Z","steps":["trace[563770717] 'process raft request' (duration: 170.803882ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:33:54.339269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.718867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-10-26T01:33:54.339268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.886801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-r5b9n\" ","response":"range_response_count:1 size:22101"} {"level":"info","ts":"2026-10-26T01:33:54.339349Z","caller":"traceutil/trace.go:171","msg":"trace[1635096431] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18936; }","duration":"402.839091ms","start":"2026-10-26T01:33:53.936491Z","end":"2026-10-26T01:33:54.33933Z","steps":["trace[1635096431] 'agreement among raft nodes before linearized reading' (duration: 402.561883ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:33:54.339392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:33:53.936475Z","time spent":"402.909073ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-26T01:33:54.339367Z","caller":"traceutil/trace.go:171","msg":"trace[49632074] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-r5b9n; range_end:; response_count:1; response_revision:18936; }","duration":"288.034204ms","start":"2026-10-26T01:33:54.051312Z","end":"2026-10-26T01:33:54.339346Z","steps":["trace[49632074] 'agreement among raft nodes before linearized reading' (duration: 287.809788ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:34:29.6215Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16907} {"level":"info","ts":"2026-10-26T01:34:29.721891Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16907,"took":"97.011718ms","hash":3723714315,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":32260096,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-26T01:34:29.721989Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3723714315,"revision":16907,"compact-revision":14597} {"level":"info","ts":"2026-10-26T01:34:31.834599Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f61dce011a423b00","local-member-applied-index":20005,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-26T01:34:31.848226Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20005} {"level":"info","ts":"2026-10-26T01:34:31.848323Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15005} {"level":"info","ts":"2026-10-26T01:39:29.628177Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19292} {"level":"info","ts":"2026-10-26T01:39:29.731326Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19292,"took":"99.556368ms","hash":3027297890,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":33796096,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-26T01:39:29.731505Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3027297890,"revision":19292,"compact-revision":16907} {"level":"info","ts":"2026-10-26T01:39:50.879404Z","caller":"traceutil/trace.go:171","msg":"trace[731741370] linearizableReadLoop","detail":"{readStateIndex:22423; appliedIndex:22422; }","duration":"180.295932ms","start":"2026-10-26T01:39:50.699054Z","end":"2026-10-26T01:39:50.87935Z","steps":["trace[731741370] 'read index received' (duration: 180.033144ms)","trace[731741370] 'applied index is now lower than readState.Index' (duration: 261.928µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:39:50.879537Z","caller":"traceutil/trace.go:171","msg":"trace[731594480] transaction","detail":"{read_only:false; response_revision:21675; number_of_response:1; }","duration":"263.205704ms","start":"2026-10-26T01:39:50.61625Z","end":"2026-10-26T01:39:50.879455Z","steps":["trace[731594480] 'process raft request' (duration: 262.926766ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:39:50.87973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.352169ms","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-26T01:39:50.87982Z","caller":"traceutil/trace.go:171","msg":"trace[616111723] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21675; }","duration":"170.462132ms","start":"2026-10-26T01:39:50.709335Z","end":"2026-10-26T01:39:50.879797Z","steps":["trace[616111723] 'agreement among raft nodes before linearized reading' (duration: 170.222735ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:39:50.880312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.218957ms","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-26T01:39:50.880435Z","caller":"traceutil/trace.go:171","msg":"trace[1420614942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21675; }","duration":"181.401782ms","start":"2026-10-26T01:39:50.699016Z","end":"2026-10-26T01:39:50.880417Z","steps":["trace[1420614942] 'agreement among raft nodes before linearized reading' (duration: 181.038152ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:40:30.408147Z","caller":"traceutil/trace.go:171","msg":"trace[235486144] transaction","detail":"{read_only:false; response_revision:21926; number_of_response:1; }","duration":"156.997676ms","start":"2026-10-26T01:40:30.251109Z","end":"2026-10-26T01:40:30.408106Z","steps":["trace[235486144] 'process raft request' (duration: 156.808151ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:40:30.408097Z","caller":"traceutil/trace.go:171","msg":"trace[1951926004] linearizableReadLoop","detail":"{readStateIndex:22682; appliedIndex:22681; }","duration":"134.898708ms","start":"2026-10-26T01:40:30.273174Z","end":"2026-10-26T01:40:30.408073Z","steps":["trace[1951926004] 'read index received' (duration: 134.689222ms)","trace[1951926004] 'applied index is now lower than readState.Index' (duration: 208.606µs)"],"step_count":2} {"level":"warn","ts":"2026-10-26T01:40:30.40829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.090903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T01:40:30.408413Z","caller":"traceutil/trace.go:171","msg":"trace[905467579] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21926; }","duration":"135.274739ms","start":"2026-10-26T01:40:30.273118Z","end":"2026-10-26T01:40:30.408392Z","steps":["trace[905467579] 'agreement among raft nodes before linearized reading' (duration: 135.078803ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:40:35.975275Z","caller":"traceutil/trace.go:171","msg":"trace[775358670] transaction","detail":"{read_only:false; response_revision:21956; number_of_response:1; }","duration":"131.774212ms","start":"2026-10-26T01:40:35.843473Z","end":"2026-10-26T01:40:35.975247Z","steps":["trace[775358670] 'process raft request' (duration: 131.604607ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:40:36.184996Z","caller":"traceutil/trace.go:171","msg":"trace[291934901] transaction","detail":"{read_only:false; response_revision:21957; number_of_response:1; }","duration":"336.098278ms","start":"2026-10-26T01:40:35.848873Z","end":"2026-10-26T01:40:36.184971Z","steps":["trace[291934901] 'process raft request' (duration: 335.858622ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:40:36.185153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:40:35.848838Z","time spent":"336.230812ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T01:40:36.185281Z","caller":"traceutil/trace.go:171","msg":"trace[1766779283] linearizableReadLoop","detail":"{readStateIndex:22716; appliedIndex:22712; }","duration":"289.820297ms","start":"2026-10-26T01:40:35.895442Z","end":"2026-10-26T01:40:36.185263Z","steps":["trace[1766779283] 'read index received' (duration: 79.640569ms)","trace[1766779283] 'applied index is now lower than readState.Index' (duration: 210.178938ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:40:36.185342Z","caller":"traceutil/trace.go:171","msg":"trace[1028299314] transaction","detail":"{read_only:false; response_revision:21959; number_of_response:1; }","duration":"304.169451ms","start":"2026-10-26T01:40:35.881118Z","end":"2026-10-26T01:40:36.185287Z","steps":["trace[1028299314] 'process raft request' (duration: 304.026897ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:40:36.185519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.055103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-10-26T01:40:36.185546Z","caller":"traceutil/trace.go:171","msg":"trace[765866515] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:21959; }","duration":"290.155036ms","start":"2026-10-26T01:40:35.895383Z","end":"2026-10-26T01:40:36.185539Z","steps":["trace[765866515] 'agreement among raft nodes before linearized reading' (duration: 289.993161ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:40:36.185632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.101205ms","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-26T01:40:36.185675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:40:35.881089Z","time spent":"304.359706ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T01:40:36.185718Z","caller":"traceutil/trace.go:171","msg":"trace[1057289171] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21959; }","duration":"250.218798ms","start":"2026-10-26T01:40:35.935485Z","end":"2026-10-26T01:40:36.185704Z","steps":["trace[1057289171] 'agreement among raft nodes before linearized reading' (duration: 249.92034ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:40:36.185318Z","caller":"traceutil/trace.go:171","msg":"trace[1440372649] transaction","detail":"{read_only:false; response_revision:21958; number_of_response:1; }","duration":"336.14211ms","start":"2026-10-26T01:40:35.849108Z","end":"2026-10-26T01:40:36.18525Z","steps":["trace[1440372649] 'process raft request' (duration: 335.809341ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:40:36.18627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:40:35.849063Z","time spent":"337.090156ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T01:44:29.636089Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21566} {"level":"info","ts":"2026-10-26T01:44:29.749132Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21566,"took":"109.396967ms","hash":1517135419,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":30019584,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-26T01:44:29.749223Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1517135419,"revision":21566,"compact-revision":19292} {"level":"info","ts":"2026-10-26T01:44:53.642332Z","caller":"traceutil/trace.go:171","msg":"trace[2264686] transaction","detail":"{read_only:false; response_revision:24501; number_of_response:1; }","duration":"133.383887ms","start":"2026-10-26T01:44:53.508914Z","end":"2026-10-26T01:44:53.642298Z","steps":["trace[2264686] 'process raft request' (duration: 132.707798ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:44:53.972118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.946783ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-26T01:44:53.972324Z","caller":"traceutil/trace.go:171","msg":"trace[1094201626] transaction","detail":"{read_only:false; response_revision:24502; number_of_response:1; }","duration":"298.920546ms","start":"2026-10-26T01:44:53.673342Z","end":"2026-10-26T01:44:53.972263Z","steps":["trace[1094201626] 'process raft request' (duration: 176.730458ms)","trace[1094201626] 'compare' (duration: 121.636423ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:44:53.972226Z","caller":"traceutil/trace.go:171","msg":"trace[1859112593] linearizableReadLoop","detail":"{readStateIndex:25335; appliedIndex:25334; }","duration":"246.882106ms","start":"2026-10-26T01:44:53.725324Z","end":"2026-10-26T01:44:53.972206Z","steps":["trace[1859112593] 'read index received' (duration: 124.720528ms)","trace[1859112593] 'applied index is now lower than readState.Index' (duration: 122.159438ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T01:44:53.973035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.780338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-26T01:44:53.973035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.660207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1936"} {"level":"info","ts":"2026-10-26T01:44:53.973082Z","caller":"traceutil/trace.go:171","msg":"trace[1772611914] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24502; }","duration":"228.850751ms","start":"2026-10-26T01:44:53.744219Z","end":"2026-10-26T01:44:53.973069Z","steps":["trace[1772611914] 'agreement among raft nodes before linearized reading' (duration: 228.770228ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:44:53.973144Z","caller":"traceutil/trace.go:171","msg":"trace[1204664128] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:24502; }","duration":"247.867293ms","start":"2026-10-26T01:44:53.725242Z","end":"2026-10-26T01:44:53.97311Z","steps":["trace[1204664128] 'agreement among raft nodes before linearized reading' (duration: 247.489442ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:47:22.785049Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006904.wal"} {"level":"warn","ts":"2026-10-26T01:48:33.399911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.73049ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-26T01:48:33.40015Z","caller":"traceutil/trace.go:171","msg":"trace[2061863724] linearizableReadLoop","detail":"{readStateIndex:27523; appliedIndex:27521; }","duration":"245.655053ms","start":"2026-10-26T01:48:33.154478Z","end":"2026-10-26T01:48:33.400133Z","steps":["trace[2061863724] 'read index received' (duration: 29.617414ms)","trace[2061863724] 'applied index is now lower than readState.Index' (duration: 216.036459ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:48:33.400249Z","caller":"traceutil/trace.go:171","msg":"trace[1049768897] transaction","detail":"{read_only:false; response_revision:26634; number_of_response:1; }","duration":"313.741594ms","start":"2026-10-26T01:48:33.086446Z","end":"2026-10-26T01:48:33.400188Z","steps":["trace[1049768897] 'process raft request' (duration: 313.615561ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:48:33.400315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.824403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T01:48:33.400345Z","caller":"traceutil/trace.go:171","msg":"trace[1785385705] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26634; }","duration":"127.877635ms","start":"2026-10-26T01:48:33.272458Z","end":"2026-10-26T01:48:33.400336Z","steps":["trace[1785385705] 'agreement among raft nodes before linearized reading' (duration: 127.818294ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:48:33.400311Z","caller":"traceutil/trace.go:171","msg":"trace[800795000] transaction","detail":"{read_only:false; response_revision:26633; number_of_response:1; }","duration":"349.820397ms","start":"2026-10-26T01:48:33.050414Z","end":"2026-10-26T01:48:33.400235Z","steps":["trace[800795000] 'process raft request' (duration: 133.660275ms)","trace[800795000] 'compare' (duration: 215.248207ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T01:48:33.400495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:48:33.086421Z","time spent":"313.9314ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T01:48:33.400558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.610815ms","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-26T01:48:33.400595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.592615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-10-26T01:48:33.400631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:48:33.050368Z","time spent":"350.070093ms","remote":"127.0.0.1:55054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":121,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T01:48:33.400661Z","caller":"traceutil/trace.go:171","msg":"trace[802784318] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26634; }","duration":"128.688338ms","start":"2026-10-26T01:48:33.271954Z","end":"2026-10-26T01:48:33.400642Z","steps":["trace[802784318] 'agreement among raft nodes before linearized reading' (duration: 128.364359ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:48:33.400629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.055454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-26T01:48:33.401009Z","caller":"traceutil/trace.go:171","msg":"trace[1097904872] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26634; }","duration":"246.580738ms","start":"2026-10-26T01:48:33.154412Z","end":"2026-10-26T01:48:33.400993Z","steps":["trace[1097904872] 'agreement among raft nodes before linearized reading' (duration: 245.808797ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:48:33.400694Z","caller":"traceutil/trace.go:171","msg":"trace[1088141287] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26634; }","duration":"144.753288ms","start":"2026-10-26T01:48:33.255879Z","end":"2026-10-26T01:48:33.400632Z","steps":["trace[1088141287] 'agreement among raft nodes before linearized reading' (duration: 144.395059ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:49:29.64776Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23756} {"level":"info","ts":"2026-10-26T01:49:29.768421Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23756,"took":"116.510153ms","hash":2540634683,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":44789760,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-10-26T01:49:29.768501Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2540634683,"revision":23756,"compact-revision":21566} {"level":"info","ts":"2026-10-26T01:49:30.594016Z","caller":"traceutil/trace.go:171","msg":"trace[188458539] transaction","detail":"{read_only:false; response_revision:27166; number_of_response:1; }","duration":"161.84881ms","start":"2026-10-26T01:49:30.432136Z","end":"2026-10-26T01:49:30.593985Z","steps":["trace[188458539] 'process raft request' (duration: 159.021002ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:49:30.595469Z","caller":"traceutil/trace.go:171","msg":"trace[303424308] transaction","detail":"{read_only:false; response_revision:27167; number_of_response:1; }","duration":"126.022804ms","start":"2026-10-26T01:49:30.469414Z","end":"2026-10-26T01:49:30.595437Z","steps":["trace[303424308] 'process raft request' (duration: 125.794428ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:49:36.128284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.120647ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-26T01:49:36.128479Z","caller":"traceutil/trace.go:171","msg":"trace[1404545944] transaction","detail":"{read_only:false; response_revision:27201; number_of_response:1; }","duration":"352.511681ms","start":"2026-10-26T01:49:35.775924Z","end":"2026-10-26T01:49:36.128435Z","steps":["trace[1404545944] 'process raft request' (duration: 158.169168ms)","trace[1404545944] 'compare' (duration: 193.995013ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:49:36.128535Z","caller":"traceutil/trace.go:171","msg":"trace[1213639201] linearizableReadLoop","detail":"{readStateIndex:28104; appliedIndex:28102; }","duration":"295.665998ms","start":"2026-10-26T01:49:35.832854Z","end":"2026-10-26T01:49:36.12852Z","steps":["trace[1213639201] 'read index received' (duration: 33.650095ms)","trace[1213639201] 'applied index is now lower than readState.Index' (duration: 262.015303ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T01:49:36.128643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.787191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12433"} {"level":"info","ts":"2026-10-26T01:49:36.128655Z","caller":"traceutil/trace.go:171","msg":"trace[160910517] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27202; }","duration":"295.837293ms","start":"2026-10-26T01:49:35.832814Z","end":"2026-10-26T01:49:36.128651Z","steps":["trace[160910517] 'agreement among raft nodes before linearized reading' (duration: 295.7433ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:49:36.12865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:49:35.775912Z","time spent":"352.650245ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T01:49:36.381423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.741511ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-26T01:49:36.381531Z","caller":"traceutil/trace.go:171","msg":"trace[699705099] transaction","detail":"{read_only:false; response_revision:27203; number_of_response:1; }","duration":"246.059694ms","start":"2026-10-26T01:49:36.135451Z","end":"2026-10-26T01:49:36.38151Z","steps":["trace[699705099] 'process raft request' (duration: 114.113647ms)","trace[699705099] 'compare' (duration: 131.469094ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:49:36.427416Z","caller":"traceutil/trace.go:171","msg":"trace[1884400126] transaction","detail":"{read_only:false; response_revision:27204; number_of_response:1; }","duration":"288.892662ms","start":"2026-10-26T01:49:36.138476Z","end":"2026-10-26T01:49:36.427369Z","steps":["trace[1884400126] 'process raft request' (duration: 288.697807ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:49:36.427586Z","caller":"traceutil/trace.go:171","msg":"trace[1122506867] linearizableReadLoop","detail":"{readStateIndex:28108; appliedIndex:28106; }","duration":"170.454796ms","start":"2026-10-26T01:49:36.257095Z","end":"2026-10-26T01:49:36.427549Z","steps":["trace[1122506867] 'read index received' (duration: 170.155428ms)","trace[1122506867] 'applied index is now lower than readState.Index' (duration: 297.218µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:49:36.427643Z","caller":"traceutil/trace.go:171","msg":"trace[574377350] transaction","detail":"{read_only:false; response_revision:27205; number_of_response:1; }","duration":"186.765075ms","start":"2026-10-26T01:49:36.240838Z","end":"2026-10-26T01:49:36.427603Z","steps":["trace[574377350] 'process raft request' (duration: 186.480127ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:49:36.427806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.689672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T01:49:36.427864Z","caller":"traceutil/trace.go:171","msg":"trace[1809563778] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:27205; }","duration":"170.820356ms","start":"2026-10-26T01:49:36.257027Z","end":"2026-10-26T01:49:36.427848Z","steps":["trace[1809563778] 'agreement among raft nodes before linearized reading' (duration: 170.687483ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:49:36.688914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.299884ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-26T01:49:36.689225Z","caller":"traceutil/trace.go:171","msg":"trace[1904010175] transaction","detail":"{read_only:false; response_revision:27206; number_of_response:1; }","duration":"352.966353ms","start":"2026-10-26T01:49:36.336132Z","end":"2026-10-26T01:49:36.689099Z","steps":["trace[1904010175] 'process raft request' (duration: 191.389621ms)","trace[1904010175] 'compare' (duration: 160.76497ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T01:49:36.689313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:49:36.336093Z","time spent":"353.176788ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T01:49:36.689899Z","caller":"traceutil/trace.go:171","msg":"trace[1370654876] transaction","detail":"{read_only:false; response_revision:27207; number_of_response:1; }","duration":"351.313257ms","start":"2026-10-26T01:49:36.338525Z","end":"2026-10-26T01:49:36.689838Z","steps":["trace[1370654876] 'process raft request' (duration: 350.516355ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:49:36.689973Z","caller":"traceutil/trace.go:171","msg":"trace[1683965669] transaction","detail":"{read_only:false; response_revision:27208; number_of_response:1; }","duration":"349.908289ms","start":"2026-10-26T01:49:36.340036Z","end":"2026-10-26T01:49:36.689944Z","steps":["trace[1683965669] 'process raft request' (duration: 349.57262ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:49:36.690108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:49:36.338493Z","time spent":"351.516003ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T01:49:36.690223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:49:36.340009Z","time spent":"350.070884ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T01:49:36.690278Z","caller":"traceutil/trace.go:171","msg":"trace[1792512439] transaction","detail":"{read_only:false; response_revision:27209; number_of_response:1; }","duration":"280.319256ms","start":"2026-10-26T01:49:36.409914Z","end":"2026-10-26T01:49:36.690233Z","steps":["trace[1792512439] 'process raft request' (duration: 279.970526ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:49:36.690429Z","caller":"traceutil/trace.go:171","msg":"trace[420936379] linearizableReadLoop","detail":"{readStateIndex:28112; appliedIndex:28108; }","duration":"262.712341ms","start":"2026-10-26T01:49:36.427674Z","end":"2026-10-26T01:49:36.690387Z","steps":["trace[420936379] 'read index received' (duration: 99.865774ms)","trace[420936379] 'applied index is now lower than readState.Index' (duration: 162.844947ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T01:49:36.6906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.333648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-26T01:49:36.690594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.366869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T01:49:36.690646Z","caller":"traceutil/trace.go:171","msg":"trace[296364811] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:27210; }","duration":"259.437711ms","start":"2026-10-26T01:49:36.431197Z","end":"2026-10-26T01:49:36.690635Z","steps":["trace[296364811] 'agreement among raft nodes before linearized reading' (duration: 259.333898ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:49:36.69063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.644683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T01:49:36.690665Z","caller":"traceutil/trace.go:171","msg":"trace[811744017] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:27210; }","duration":"319.495602ms","start":"2026-10-26T01:49:36.371151Z","end":"2026-10-26T01:49:36.690647Z","steps":["trace[811744017] 'agreement among raft nodes before linearized reading' (duration: 319.301847ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:49:36.690708Z","caller":"traceutil/trace.go:171","msg":"trace[1704518124] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27210; }","duration":"420.761976ms","start":"2026-10-26T01:49:36.269922Z","end":"2026-10-26T01:49:36.690684Z","steps":["trace[1704518124] 'agreement among raft nodes before linearized reading' (duration: 420.588042ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T01:49:36.690708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:49:36.371136Z","time spent":"319.561055ms","remote":"127.0.0.1:34490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":0,"response size":30,"request content":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true "} {"level":"warn","ts":"2026-10-26T01:49:36.690748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T01:49:36.269901Z","time spent":"420.840049ms","remote":"127.0.0.1:55042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-26T01:49:40.891158Z","caller":"traceutil/trace.go:171","msg":"trace[1787140771] transaction","detail":"{read_only:false; response_revision:27238; number_of_response:1; }","duration":"186.485967ms","start":"2026-10-26T01:49:40.704638Z","end":"2026-10-26T01:49:40.891124Z","steps":["trace[1787140771] 'process raft request' (duration: 176.03441ms)","trace[1787140771] 'compare' (duration: 10.092617ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T01:49:40.891256Z","caller":"traceutil/trace.go:171","msg":"trace[845111320] transaction","detail":"{read_only:false; response_revision:27239; number_of_response:1; }","duration":"186.037925ms","start":"2026-10-26T01:49:40.705182Z","end":"2026-10-26T01:49:40.89122Z","steps":["trace[845111320] 'process raft request' (duration: 185.741647ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:49:40.892032Z","caller":"traceutil/trace.go:171","msg":"trace[1627876099] transaction","detail":"{read_only:false; response_revision:27240; number_of_response:1; }","duration":"186.57433ms","start":"2026-10-26T01:49:40.705442Z","end":"2026-10-26T01:49:40.892016Z","steps":["trace[1627876099] 'process raft request' (duration: 185.539621ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:49:40.892148Z","caller":"traceutil/trace.go:171","msg":"trace[1503495695] transaction","detail":"{read_only:false; response_revision:27241; number_of_response:1; }","duration":"186.363533ms","start":"2026-10-26T01:49:40.705773Z","end":"2026-10-26T01:49:40.892136Z","steps":["trace[1503495695] 'process raft request' (duration: 186.109116ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T01:52:47.667991Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f61dce011a423b00","local-member-applied-index":30006,"local-member-snapshot-index":20005,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-26T01:52:47.675732Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30006} {"level":"info","ts":"2026-10-26T01:52:47.676012Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25006} {"level":"info","ts":"2026-10-26T01:54:29.654365Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27153} {"level":"info","ts":"2026-10-26T01:54:29.816505Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27153,"took":"157.686245ms","hash":913521199,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":35991552,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-26T01:54:29.816581Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":913521199,"revision":27153,"compact-revision":23756} {"level":"info","ts":"2026-10-26T01:59:29.661429Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30031} {"level":"info","ts":"2026-10-26T01:59:29.81Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30031,"took":"144.267567ms","hash":449031570,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":31186944,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-26T01:59:29.810073Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":449031570,"revision":30031,"compact-revision":27153} {"level":"info","ts":"2026-10-26T02:04:29.667807Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32292} {"level":"info","ts":"2026-10-26T02:04:29.825866Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32292,"took":"153.723917ms","hash":3639705512,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":30539776,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-26T02:04:29.825974Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3639705512,"revision":32292,"compact-revision":30031} {"level":"info","ts":"2026-10-26T02:09:29.67526Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34579} {"level":"info","ts":"2026-10-26T02:09:29.814482Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34579,"took":"134.382506ms","hash":2996950406,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":30793728,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-26T02:09:29.814554Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2996950406,"revision":34579,"compact-revision":32292} {"level":"info","ts":"2026-10-26T02:13:33.962098Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f61dce011a423b00","local-member-applied-index":40007,"local-member-snapshot-index":30006,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-26T02:13:33.96844Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40007} {"level":"info","ts":"2026-10-26T02:13:33.968585Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35007} {"level":"info","ts":"2026-10-26T02:14:29.682378Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":36880} {"level":"info","ts":"2026-10-26T02:14:29.818191Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":36880,"took":"131.452286ms","hash":339382641,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":33419264,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-26T02:14:29.818261Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":339382641,"revision":36880,"compact-revision":34579} {"level":"info","ts":"2026-10-26T02:19:29.689793Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39186} {"level":"info","ts":"2026-10-26T02:19:29.838877Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39186,"took":"134.93373ms","hash":537201004,"current-db-size-bytes":57774080,"current-db-size":"58 MB","current-db-size-in-use-bytes":31715328,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-26T02:19:29.838944Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":537201004,"revision":39186,"compact-revision":36880}