{"level":"warn","ts":"2026-08-15T02:32:24.809424Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-15T02:32:24.809532Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.192:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.192:2380","--initial-cluster=instance=https://199.19.213.192:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.192:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.192: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-08-15T02:32:24.809616Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-15T02:32:24.809633Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.192:2380"]} {"level":"info","ts":"2026-08-15T02:32:24.809659Z","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-08-15T02:32:24.810644Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.192:2379"]} {"level":"info","ts":"2026-08-15T02:32:24.810754Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.192:2380"],"listen-peer-urls":["https://199.19.213.192:2380"],"advertise-client-urls":["https://199.19.213.192:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.192:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.192: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-08-15T02:32:24.815461Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.419983ms"} {"level":"info","ts":"2026-08-15T02:32:24.822922Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"341a3703c39c1f5b","cluster-id":"65341987fa712ba2"} {"level":"info","ts":"2026-08-15T02:32:24.823038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b switched to configuration voters=()"} {"level":"info","ts":"2026-08-15T02:32:24.823086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b became follower at term 0"} {"level":"info","ts":"2026-08-15T02:32:24.823112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 341a3703c39c1f5b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-15T02:32:24.823134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b became follower at term 1"} {"level":"info","ts":"2026-08-15T02:32:24.823196Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b switched to configuration voters=(3754373728672948059)"} {"level":"warn","ts":"2026-08-15T02:32:24.834076Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-15T02:32:24.835733Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-15T02:32:24.836934Z","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-08-15T02:32:24.839029Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"341a3703c39c1f5b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-15T02:32:24.839201Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"341a3703c39c1f5b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-15T02:32:24.839335Z","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-08-15T02:32:24.839397Z","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-08-15T02:32:24.839408Z","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-08-15T02:32:24.841354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b switched to configuration voters=(3754373728672948059)"} {"level":"info","ts":"2026-08-15T02:32:24.841623Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"65341987fa712ba2","local-member-id":"341a3703c39c1f5b","added-peer-id":"341a3703c39c1f5b","added-peer-peer-urls":["https://199.19.213.192:2380"]} {"level":"info","ts":"2026-08-15T02:32:24.843368Z","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-08-15T02:32:24.843416Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.192:2380"} {"level":"info","ts":"2026-08-15T02:32:24.843494Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.192:2380"} {"level":"info","ts":"2026-08-15T02:32:24.843679Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"341a3703c39c1f5b","initial-advertise-peer-urls":["https://199.19.213.192:2380"],"listen-peer-urls":["https://199.19.213.192:2380"],"advertise-client-urls":["https://199.19.213.192:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.192:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-15T02:32:24.84372Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-15T02:32:25.824394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b is starting a new election at term 1"} {"level":"info","ts":"2026-08-15T02:32:25.824454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b became pre-candidate at term 1"} {"level":"info","ts":"2026-08-15T02:32:25.824517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b received MsgPreVoteResp from 341a3703c39c1f5b at term 1"} {"level":"info","ts":"2026-08-15T02:32:25.824534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b became candidate at term 2"} {"level":"info","ts":"2026-08-15T02:32:25.824541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b received MsgVoteResp from 341a3703c39c1f5b at term 2"} {"level":"info","ts":"2026-08-15T02:32:25.824552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b became leader at term 2"} {"level":"info","ts":"2026-08-15T02:32:25.82456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 341a3703c39c1f5b elected leader 341a3703c39c1f5b at term 2"} {"level":"info","ts":"2026-08-15T02:32:25.827659Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"341a3703c39c1f5b","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.192:2379]}","request-path":"/0/members/341a3703c39c1f5b/attributes","cluster-id":"65341987fa712ba2","publish-timeout":"7s"} {"level":"info","ts":"2026-08-15T02:32:25.827678Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-15T02:32:25.82772Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-15T02:32:25.827705Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-15T02:32:25.827946Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-15T02:32:25.827973Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-15T02:32:25.828629Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"65341987fa712ba2","local-member-id":"341a3703c39c1f5b","cluster-version":"3.5"} {"level":"info","ts":"2026-08-15T02:32:25.828896Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-15T02:32:25.828953Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-15T02:32:25.830947Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.192:2379"} {"level":"info","ts":"2026-08-15T02:32:25.830967Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-15T02:32:28.757225Z","caller":"traceutil/trace.go:171","msg":"trace[860207250] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"126.141209ms","start":"2026-08-15T02:32:28.631051Z","end":"2026-08-15T02:32:28.757193Z","steps":["trace[860207250] 'process raft request' (duration: 82.48364ms)","trace[860207250] 'compare' (duration: 43.517525ms)"],"step_count":2} {"level":"info","ts":"2026-08-15T02:32:40.961151Z","caller":"traceutil/trace.go:171","msg":"trace[555122577] linearizableReadLoop","detail":"{readStateIndex:426; appliedIndex:425; }","duration":"128.205936ms","start":"2026-08-15T02:32:40.832921Z","end":"2026-08-15T02:32:40.961127Z","steps":["trace[555122577] 'read index received' (duration: 128.010911ms)","trace[555122577] 'applied index is now lower than readState.Index' (duration: 193.905µs)"],"step_count":2} {"level":"info","ts":"2026-08-15T02:32:40.961202Z","caller":"traceutil/trace.go:171","msg":"trace[332887354] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"255.383972ms","start":"2026-08-15T02:32:40.705782Z","end":"2026-08-15T02:32:40.961166Z","steps":["trace[332887354] 'process raft request' (duration: 255.212567ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:32:40.961322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.384692ms","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-08-15T02:32:40.961444Z","caller":"traceutil/trace.go:171","msg":"trace[1311893904] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:410; }","duration":"128.554946ms","start":"2026-08-15T02:32:40.832868Z","end":"2026-08-15T02:32:40.961423Z","steps":["trace[1311893904] 'agreement among raft nodes before linearized reading' (duration: 128.365521ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:32:41.304558Z","caller":"traceutil/trace.go:171","msg":"trace[871435100] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"338.749087ms","start":"2026-08-15T02:32:40.965776Z","end":"2026-08-15T02:32:41.304525Z","steps":["trace[871435100] 'process raft request' (duration: 338.563772ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:32:41.305637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-15T02:32:40.965752Z","time spent":"338.906292ms","remote":"127.0.0.1:38314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-15T02:32:41.368419Z","caller":"traceutil/trace.go:171","msg":"trace[1838893103] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"402.233718ms","start":"2026-08-15T02:32:40.966158Z","end":"2026-08-15T02:32:41.368392Z","steps":["trace[1838893103] 'process raft request' (duration: 402.050882ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:32:41.368529Z","caller":"traceutil/trace.go:171","msg":"trace[634255362] linearizableReadLoop","detail":"{readStateIndex:429; appliedIndex:426; }","duration":"222.246054ms","start":"2026-08-15T02:32:41.146255Z","end":"2026-08-15T02:32:41.368501Z","steps":["trace[634255362] 'read index received' (duration: 158.153236ms)","trace[634255362] 'applied index is now lower than readState.Index' (duration: 64.090928ms)"],"step_count":2} {"level":"warn","ts":"2026-08-15T02:32:41.368584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-15T02:32:40.966131Z","time spent":"402.370772ms","remote":"127.0.0.1:38314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-15T02:32:41.368671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.411788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-08-15T02:32:41.368665Z","caller":"traceutil/trace.go:171","msg":"trace[1409464472] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"366.472273ms","start":"2026-08-15T02:32:41.002106Z","end":"2026-08-15T02:32:41.368578Z","steps":["trace[1409464472] 'process raft request' (duration: 366.246086ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:32:41.368753Z","caller":"traceutil/trace.go:171","msg":"trace[422136606] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:413; }","duration":"222.538641ms","start":"2026-08-15T02:32:41.14619Z","end":"2026-08-15T02:32:41.368729Z","steps":["trace[422136606] 'agreement among raft nodes before linearized reading' (duration: 222.405438ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:32:41.368887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-15T02:32:41.002082Z","time spent":"366.724641ms","remote":"127.0.0.1:38314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-15T02:32:41.36894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.953059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-15T02:32:41.369108Z","caller":"traceutil/trace.go:171","msg":"trace[574022372] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:413; }","duration":"214.146484ms","start":"2026-08-15T02:32:41.154942Z","end":"2026-08-15T02:32:41.369088Z","steps":["trace[574022372] 'agreement among raft nodes before linearized reading' (duration: 213.956519ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:33:16.433337Z","caller":"traceutil/trace.go:171","msg":"trace[1390214510] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"105.186222ms","start":"2026-08-15T02:33:16.328124Z","end":"2026-08-15T02:33:16.433311Z","steps":["trace[1390214510] 'process raft request' (duration: 95.902329ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:33:16.433677Z","caller":"traceutil/trace.go:171","msg":"trace[1452732929] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"102.884768ms","start":"2026-08-15T02:33:16.330774Z","end":"2026-08-15T02:33:16.433658Z","steps":["trace[1452732929] 'process raft request' (duration: 102.60562ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:33:22.448027Z","caller":"traceutil/trace.go:171","msg":"trace[969490638] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"128.852404ms","start":"2026-08-15T02:33:22.319146Z","end":"2026-08-15T02:33:22.447998Z","steps":["trace[969490638] 'process raft request' (duration: 128.640108ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:33:23.223937Z","caller":"traceutil/trace.go:171","msg":"trace[779204072] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"356.645834ms","start":"2026-08-15T02:33:22.867261Z","end":"2026-08-15T02:33:23.223907Z","steps":["trace[779204072] 'process raft request' (duration: 356.435398ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:33:23.224122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-15T02:33:22.867216Z","time spent":"356.81811ms","remote":"127.0.0.1:38232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-15T02:33:23.23125Z","caller":"traceutil/trace.go:171","msg":"trace[2100507499] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"327.731644ms","start":"2026-08-15T02:33:22.903497Z","end":"2026-08-15T02:33:23.231228Z","steps":["trace[2100507499] 'process raft request' (duration: 327.21518ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:33:23.231438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-15T02:33:22.903467Z","time spent":"327.848838ms","remote":"127.0.0.1:38126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-15T02:33:39.342732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.790214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-15T02:33:39.342842Z","caller":"traceutil/trace.go:171","msg":"trace[1361076585] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:834; }","duration":"185.941928ms","start":"2026-08-15T02:33:39.15687Z","end":"2026-08-15T02:33:39.342812Z","steps":["trace[1361076585] 'range keys from in-memory index tree' (duration: 185.66248ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:34:55.464955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.647196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-08-15T02:34:55.464979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.102291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-15T02:34:55.465028Z","caller":"traceutil/trace.go:171","msg":"trace[892949119] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1910; }","duration":"151.77175ms","start":"2026-08-15T02:34:55.313239Z","end":"2026-08-15T02:34:55.46501Z","steps":["trace[892949119] 'range keys from in-memory index tree' (duration: 151.470901ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:34:55.465077Z","caller":"traceutil/trace.go:171","msg":"trace[1212277896] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1910; }","duration":"308.235934ms","start":"2026-08-15T02:34:55.156818Z","end":"2026-08-15T02:34:55.465054Z","steps":["trace[1212277896] 'range keys from in-memory index tree' (duration: 307.989968ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:34:55.465159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-15T02:34:55.156802Z","time spent":"308.342278ms","remote":"127.0.0.1:37998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-15T02:34:55.465038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.257829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-15T02:34:55.465328Z","caller":"traceutil/trace.go:171","msg":"trace[975896716] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1910; }","duration":"348.58993ms","start":"2026-08-15T02:34:55.116723Z","end":"2026-08-15T02:34:55.465313Z","steps":["trace[975896716] 'range keys from in-memory index tree' (duration: 348.046783ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:34:55.46537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.767903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-999ea7ae-f5a6-4dd9-a22a-476429dbc20e\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-08-15T02:34:55.465372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-15T02:34:55.116698Z","time spent":"348.659852ms","remote":"127.0.0.1:38314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-15T02:34:55.465643Z","caller":"traceutil/trace.go:171","msg":"trace[916261645] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-999ea7ae-f5a6-4dd9-a22a-476429dbc20e; range_end:; response_count:1; response_revision:1910; }","duration":"114.065412ms","start":"2026-08-15T02:34:55.351566Z","end":"2026-08-15T02:34:55.465632Z","steps":["trace[916261645] 'range keys from in-memory index tree' (duration: 113.65528ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:34:55.591517Z","caller":"traceutil/trace.go:171","msg":"trace[1928389865] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"118.603313ms","start":"2026-08-15T02:34:55.472885Z","end":"2026-08-15T02:34:55.591488Z","steps":["trace[1928389865] 'process raft request' (duration: 118.47296ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:34:56.103726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.093694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-15T02:34:56.103806Z","caller":"traceutil/trace.go:171","msg":"trace[2025285415] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1912; }","duration":"121.242559ms","start":"2026-08-15T02:34:55.982548Z","end":"2026-08-15T02:34:56.103791Z","steps":["trace[2025285415] 'range keys from in-memory index tree' (duration: 120.93736ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:35:11.885575Z","caller":"traceutil/trace.go:171","msg":"trace[710808789] transaction","detail":"{read_only:false; response_revision:2047; number_of_response:1; }","duration":"230.4446ms","start":"2026-08-15T02:35:11.655094Z","end":"2026-08-15T02:35:11.885539Z","steps":["trace[710808789] 'process raft request' (duration: 230.269255ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:35:44.549168Z","caller":"traceutil/trace.go:171","msg":"trace[1810020592] linearizableReadLoop","detail":"{readStateIndex:2316; appliedIndex:2315; }","duration":"104.260428ms","start":"2026-08-15T02:35:44.444886Z","end":"2026-08-15T02:35:44.549147Z","steps":["trace[1810020592] 'read index received' (duration: 57.023635ms)","trace[1810020592] 'applied index is now lower than readState.Index' (duration: 47.235893ms)"],"step_count":2} {"level":"info","ts":"2026-08-15T02:35:44.549287Z","caller":"traceutil/trace.go:171","msg":"trace[1072780009] transaction","detail":"{read_only:false; response_revision:2226; number_of_response:1; }","duration":"109.973873ms","start":"2026-08-15T02:35:44.439292Z","end":"2026-08-15T02:35:44.549266Z","steps":["trace[1072780009] 'process raft request' (duration: 62.673488ms)","trace[1072780009] 'compare' (duration: 47.068968ms)"],"step_count":2} {"level":"warn","ts":"2026-08-15T02:35:44.549531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.621919ms","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-08-15T02:35:44.549602Z","caller":"traceutil/trace.go:171","msg":"trace[942820109] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2226; }","duration":"104.736532ms","start":"2026-08-15T02:35:44.44485Z","end":"2026-08-15T02:35:44.549587Z","steps":["trace[942820109] 'agreement among raft nodes before linearized reading' (duration: 104.524456ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:35:44.5934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.879267ms","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-08-15T02:35:44.593458Z","caller":"traceutil/trace.go:171","msg":"trace[1323877063] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2227; }","duration":"139.972009ms","start":"2026-08-15T02:35:44.453474Z","end":"2026-08-15T02:35:44.593446Z","steps":["trace[1323877063] 'agreement among raft nodes before linearized reading' (duration: 139.807184ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:35:45.029955Z","caller":"traceutil/trace.go:171","msg":"trace[757127062] transaction","detail":"{read_only:false; response_revision:2233; number_of_response:1; }","duration":"132.73011ms","start":"2026-08-15T02:35:44.897199Z","end":"2026-08-15T02:35:45.029929Z","steps":["trace[757127062] 'process raft request' (duration: 132.543995ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:35:50.571997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.288481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-15T02:35:50.572087Z","caller":"traceutil/trace.go:171","msg":"trace[1976408869] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2257; }","duration":"111.451085ms","start":"2026-08-15T02:35:50.460614Z","end":"2026-08-15T02:35:50.572065Z","steps":["trace[1976408869] 'agreement among raft nodes before linearized reading' (duration: 111.200198ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:35:50.571642Z","caller":"traceutil/trace.go:171","msg":"trace[371757281] linearizableReadLoop","detail":"{readStateIndex:2348; appliedIndex:2347; }","duration":"110.9136ms","start":"2026-08-15T02:35:50.460695Z","end":"2026-08-15T02:35:50.571609Z","steps":["trace[371757281] 'read index received' (duration: 110.759205ms)","trace[371757281] 'applied index is now lower than readState.Index' (duration: 152.225µs)"],"step_count":2} {"level":"info","ts":"2026-08-15T02:35:50.572332Z","caller":"traceutil/trace.go:171","msg":"trace[853031644] transaction","detail":"{read_only:false; response_revision:2257; number_of_response:1; }","duration":"136.110496ms","start":"2026-08-15T02:35:50.43565Z","end":"2026-08-15T02:35:50.571761Z","steps":["trace[853031644] 'process raft request' (duration: 135.794367ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:35:50.863211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.312992ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-15T02:35:50.863351Z","caller":"traceutil/trace.go:171","msg":"trace[1987979952] transaction","detail":"{read_only:false; response_revision:2258; number_of_response:1; }","duration":"293.601214ms","start":"2026-08-15T02:35:50.569726Z","end":"2026-08-15T02:35:50.863327Z","steps":["trace[1987979952] 'process raft request' (duration: 167.923041ms)","trace[1987979952] 'compare' (duration: 125.158138ms)"],"step_count":2} {"level":"info","ts":"2026-08-15T02:35:50.940982Z","caller":"traceutil/trace.go:171","msg":"trace[1461909060] transaction","detail":"{read_only:false; response_revision:2259; number_of_response:1; }","duration":"364.40837ms","start":"2026-08-15T02:35:50.576536Z","end":"2026-08-15T02:35:50.940944Z","steps":["trace[1461909060] 'process raft request' (duration: 364.029079ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:35:50.941212Z","caller":"traceutil/trace.go:171","msg":"trace[1970085191] transaction","detail":"{read_only:false; response_revision:2260; number_of_response:1; }","duration":"321.222614ms","start":"2026-08-15T02:35:50.619958Z","end":"2026-08-15T02:35:50.941181Z","steps":["trace[1970085191] 'process raft request' (duration: 320.925524ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:35:50.94122Z","caller":"traceutil/trace.go:171","msg":"trace[803830334] linearizableReadLoop","detail":"{readStateIndex:2351; appliedIndex:2348; }","duration":"312.246023ms","start":"2026-08-15T02:35:50.628918Z","end":"2026-08-15T02:35:50.941164Z","steps":["trace[803830334] 'read index received' (duration: 108.824077ms)","trace[803830334] 'applied index is now lower than readState.Index' (duration: 203.419266ms)"],"step_count":2} {"level":"warn","ts":"2026-08-15T02:35:50.941308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-15T02:35:50.576509Z","time spent":"364.70246ms","remote":"127.0.0.1:38314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-15T02:35:50.94142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.498162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-15T02:35:50.941311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-15T02:35:50.619934Z","time spent":"321.324967ms","remote":"127.0.0.1:38314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-15T02:35:50.941485Z","caller":"traceutil/trace.go:171","msg":"trace[1786317645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2260; }","duration":"312.619325ms","start":"2026-08-15T02:35:50.628849Z","end":"2026-08-15T02:35:50.941469Z","steps":["trace[1786317645] 'agreement among raft nodes before linearized reading' (duration: 312.455721ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:35:50.941536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-15T02:35:50.628828Z","time spent":"312.692278ms","remote":"127.0.0.1:38314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-15T02:35:51.062447Z","caller":"traceutil/trace.go:171","msg":"trace[1987747812] transaction","detail":"{read_only:false; response_revision:2262; number_of_response:1; }","duration":"240.719547ms","start":"2026-08-15T02:35:50.821701Z","end":"2026-08-15T02:35:51.062421Z","steps":["trace[1987747812] 'process raft request' (duration: 240.650135ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:35:51.062488Z","caller":"traceutil/trace.go:171","msg":"trace[214988562] transaction","detail":"{read_only:false; response_revision:2263; number_of_response:1; }","duration":"116.431036ms","start":"2026-08-15T02:35:50.946035Z","end":"2026-08-15T02:35:51.062467Z","steps":["trace[214988562] 'process raft request' (duration: 116.385964ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:35:51.062479Z","caller":"traceutil/trace.go:171","msg":"trace[2137467604] transaction","detail":"{read_only:false; response_revision:2261; number_of_response:1; }","duration":"256.220043ms","start":"2026-08-15T02:35:50.806222Z","end":"2026-08-15T02:35:51.062442Z","steps":["trace[2137467604] 'process raft request' (duration: 255.230452ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:35:51.062942Z","caller":"traceutil/trace.go:171","msg":"trace[1424982802] linearizableReadLoop","detail":"{readStateIndex:2353; appliedIndex:2351; }","duration":"121.373053ms","start":"2026-08-15T02:35:50.941288Z","end":"2026-08-15T02:35:51.062661Z","steps":["trace[1424982802] 'read index received' (duration: 120.180867ms)","trace[1424982802] 'applied index is now lower than readState.Index' (duration: 1.189856ms)"],"step_count":2} {"level":"warn","ts":"2026-08-15T02:35:51.063017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.021118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-15T02:35:51.063027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.036015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-15T02:35:51.063072Z","caller":"traceutil/trace.go:171","msg":"trace[315258498] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2263; }","duration":"410.125552ms","start":"2026-08-15T02:35:50.652934Z","end":"2026-08-15T02:35:51.06306Z","steps":["trace[315258498] 'agreement among raft nodes before linearized reading' (duration: 409.971768ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:35:51.063084Z","caller":"traceutil/trace.go:171","msg":"trace[1668104619] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2263; }","duration":"194.252371ms","start":"2026-08-15T02:35:50.868817Z","end":"2026-08-15T02:35:51.063069Z","steps":["trace[1668104619] 'agreement among raft nodes before linearized reading' (duration: 193.906341ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:35:51.063113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-15T02:35:50.652917Z","time spent":"410.187893ms","remote":"127.0.0.1:38314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-15T02:36:24.493318Z","caller":"traceutil/trace.go:171","msg":"trace[1662198568] transaction","detail":"{read_only:false; response_revision:2616; number_of_response:1; }","duration":"251.959284ms","start":"2026-08-15T02:36:24.241329Z","end":"2026-08-15T02:36:24.493288Z","steps":["trace[1662198568] 'process raft request' (duration: 251.757248ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:40:54.320258Z","caller":"traceutil/trace.go:171","msg":"trace[1985932014] transaction","detail":"{read_only:false; response_revision:4854; number_of_response:1; }","duration":"104.760885ms","start":"2026-08-15T02:40:54.215462Z","end":"2026-08-15T02:40:54.320223Z","steps":["trace[1985932014] 'process raft request' (duration: 104.597659ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:40:57.25467Z","caller":"traceutil/trace.go:171","msg":"trace[742125786] transaction","detail":"{read_only:false; response_revision:4999; number_of_response:1; }","duration":"123.639613ms","start":"2026-08-15T02:40:57.130998Z","end":"2026-08-15T02:40:57.254638Z","steps":["trace[742125786] 'process raft request' (duration: 123.464567ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:41:05.261172Z","caller":"traceutil/trace.go:171","msg":"trace[499141424] transaction","detail":"{read_only:false; response_revision:5162; number_of_response:1; }","duration":"109.575522ms","start":"2026-08-15T02:41:05.151567Z","end":"2026-08-15T02:41:05.261143Z","steps":["trace[499141424] 'process raft request' (duration: 95.987789ms)","trace[499141424] 'compare' (duration: 13.399616ms)"],"step_count":2} {"level":"warn","ts":"2026-08-15T02:41:05.261708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.018497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-15T02:41:05.261781Z","caller":"traceutil/trace.go:171","msg":"trace[1955408396] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5166; }","duration":"104.136902ms","start":"2026-08-15T02:41:05.157629Z","end":"2026-08-15T02:41:05.261766Z","steps":["trace[1955408396] 'agreement among raft nodes before linearized reading' (duration: 104.003857ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:41:11.304767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.489975ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-15T02:41:11.304965Z","caller":"traceutil/trace.go:171","msg":"trace[1968243155] linearizableReadLoop","detail":"{readStateIndex:5481; appliedIndex:5480; }","duration":"319.351661ms","start":"2026-08-15T02:41:10.985588Z","end":"2026-08-15T02:41:11.304939Z","steps":["trace[1968243155] 'read index received' (duration: 25.546144ms)","trace[1968243155] 'applied index is now lower than readState.Index' (duration: 293.801997ms)"],"step_count":2} {"level":"info","ts":"2026-08-15T02:41:11.305131Z","caller":"traceutil/trace.go:171","msg":"trace[216961532] transaction","detail":"{read_only:false; response_revision:5279; number_of_response:1; }","duration":"380.58356ms","start":"2026-08-15T02:41:10.924521Z","end":"2026-08-15T02:41:11.305105Z","steps":["trace[216961532] 'process raft request' (duration: 86.594735ms)","trace[216961532] 'compare' (duration: 293.196464ms)"],"step_count":2} {"level":"warn","ts":"2026-08-15T02:41:11.305226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-15T02:41:10.924501Z","time spent":"380.685124ms","remote":"127.0.0.1:38086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":129734,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-15T02:41:11.305313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.704694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-15T02:41:11.305305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.568363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-15T02:41:11.305391Z","caller":"traceutil/trace.go:171","msg":"trace[330216195] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:5279; }","duration":"319.83222ms","start":"2026-08-15T02:41:10.985537Z","end":"2026-08-15T02:41:11.305369Z","steps":["trace[330216195] 'agreement among raft nodes before linearized reading' (duration: 319.597241ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:41:11.305417Z","caller":"traceutil/trace.go:171","msg":"trace[1214697242] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5279; }","duration":"148.74313ms","start":"2026-08-15T02:41:11.156648Z","end":"2026-08-15T02:41:11.305391Z","steps":["trace[1214697242] 'agreement among raft nodes before linearized reading' (duration: 148.49517ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:41:11.305439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-15T02:41:10.985518Z","time spent":"319.910763ms","remote":"127.0.0.1:38264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-08-15T02:41:19.729928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.426667ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-15T02:41:19.730128Z","caller":"traceutil/trace.go:171","msg":"trace[249666441] linearizableReadLoop","detail":"{readStateIndex:5662; appliedIndex:5659; }","duration":"258.473316ms","start":"2026-08-15T02:41:19.471639Z","end":"2026-08-15T02:41:19.730112Z","steps":["trace[249666441] 'read index received' (duration: 75.80917ms)","trace[249666441] 'applied index is now lower than readState.Index' (duration: 182.663346ms)"],"step_count":2} {"level":"info","ts":"2026-08-15T02:41:19.730149Z","caller":"traceutil/trace.go:171","msg":"trace[210284494] transaction","detail":"{read_only:false; response_revision:5456; number_of_response:1; }","duration":"290.243349ms","start":"2026-08-15T02:41:19.439874Z","end":"2026-08-15T02:41:19.730118Z","steps":["trace[210284494] 'process raft request' (duration: 107.557223ms)","trace[210284494] 'compare' (duration: 182.25919ms)"],"step_count":2} {"level":"warn","ts":"2026-08-15T02:41:19.730284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.645443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-49207596-0761-4519-9409-d6e3d68b5f76\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-08-15T02:41:19.730315Z","caller":"traceutil/trace.go:171","msg":"trace[1741642711] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-49207596-0761-4519-9409-d6e3d68b5f76; range_end:; response_count:1; response_revision:5457; }","duration":"258.676314ms","start":"2026-08-15T02:41:19.471628Z","end":"2026-08-15T02:41:19.730305Z","steps":["trace[1741642711] 'agreement among raft nodes before linearized reading' (duration: 258.536789ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:41:19.730423Z","caller":"traceutil/trace.go:171","msg":"trace[1231599980] transaction","detail":"{read_only:false; response_revision:5457; number_of_response:1; }","duration":"271.378133ms","start":"2026-08-15T02:41:19.459008Z","end":"2026-08-15T02:41:19.730386Z","steps":["trace[1231599980] 'process raft request' (duration: 271.04775ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:41:19.730403Z","caller":"traceutil/trace.go:171","msg":"trace[1313084677] transaction","detail":"{read_only:false; number_of_response:1; response_revision:5456; }","duration":"290.347484ms","start":"2026-08-15T02:41:19.439976Z","end":"2026-08-15T02:41:19.730323Z","steps":["trace[1313084677] 'process raft request' (duration: 290.040481ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:41:20.027206Z","caller":"traceutil/trace.go:171","msg":"trace[569205197] transaction","detail":"{read_only:false; response_revision:5458; number_of_response:1; }","duration":"288.396389ms","start":"2026-08-15T02:41:19.738785Z","end":"2026-08-15T02:41:20.027181Z","steps":["trace[569205197] 'process raft request' (duration: 280.747444ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:41:20.031411Z","caller":"traceutil/trace.go:171","msg":"trace[1130124294] transaction","detail":"{read_only:false; response_revision:5459; number_of_response:1; }","duration":"292.358981ms","start":"2026-08-15T02:41:19.739011Z","end":"2026-08-15T02:41:20.03137Z","steps":["trace[1130124294] 'process raft request' (duration: 291.974646ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:41:20.031844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.573479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-15T02:41:20.031954Z","caller":"traceutil/trace.go:171","msg":"trace[424001197] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5460; }","duration":"231.746926ms","start":"2026-08-15T02:41:19.800189Z","end":"2026-08-15T02:41:20.031936Z","steps":["trace[424001197] 'agreement among raft nodes before linearized reading' (duration: 231.561859ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:41:20.032132Z","caller":"traceutil/trace.go:171","msg":"trace[1655571312] linearizableReadLoop","detail":"{readStateIndex:5664; appliedIndex:5662; }","duration":"231.344211ms","start":"2026-08-15T02:41:19.800233Z","end":"2026-08-15T02:41:20.031577Z","steps":["trace[1655571312] 'read index received' (duration: 219.317808ms)","trace[1655571312] 'applied index is now lower than readState.Index' (duration: 12.025003ms)"],"step_count":2} {"level":"info","ts":"2026-08-15T02:42:25.853716Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2976} {"level":"info","ts":"2026-08-15T02:42:25.92211Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2976,"took":"66.797771ms","hash":3170246691,"current-db-size-bytes":58961920,"current-db-size":"59 MB","current-db-size-in-use-bytes":33943552,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-15T02:42:25.922183Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3170246691,"revision":2976,"compact-revision":-1} {"level":"info","ts":"2026-08-15T02:47:25.860371Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6052} {"level":"info","ts":"2026-08-15T02:47:25.955457Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6052,"took":"92.311967ms","hash":835109843,"current-db-size-bytes":58961920,"current-db-size":"59 MB","current-db-size-in-use-bytes":21450752,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-08-15T02:47:25.955532Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":835109843,"revision":6052,"compact-revision":2976} {"level":"info","ts":"2026-08-15T02:47:49.652584Z","caller":"traceutil/trace.go:171","msg":"trace[1624991232] transaction","detail":"{read_only:false; response_revision:8398; number_of_response:1; }","duration":"205.565916ms","start":"2026-08-15T02:47:49.446956Z","end":"2026-08-15T02:47:49.652522Z","steps":["trace[1624991232] 'process raft request' (duration: 128.290903ms)","trace[1624991232] 'compare' (duration: 76.890143ms)"],"step_count":2} {"level":"info","ts":"2026-08-15T02:47:49.652901Z","caller":"traceutil/trace.go:171","msg":"trace[20210271] transaction","detail":"{read_only:false; response_revision:8399; number_of_response:1; }","duration":"202.115053ms","start":"2026-08-15T02:47:49.450757Z","end":"2026-08-15T02:47:49.652872Z","steps":["trace[20210271] 'process raft request' (duration: 201.529077ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:47:50.410352Z","caller":"traceutil/trace.go:171","msg":"trace[145308899] transaction","detail":"{read_only:false; response_revision:8403; number_of_response:1; }","duration":"217.598874ms","start":"2026-08-15T02:47:50.192722Z","end":"2026-08-15T02:47:50.41032Z","steps":["trace[145308899] 'process raft request' (duration: 217.43425ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:47:51.925962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.269663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-08-15T02:47:51.926059Z","caller":"traceutil/trace.go:171","msg":"trace[506046159] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:8410; }","duration":"135.424247ms","start":"2026-08-15T02:47:51.790612Z","end":"2026-08-15T02:47:51.926037Z","steps":["trace[506046159] 'range keys from in-memory index tree' (duration: 135.071838ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:48:18.527951Z","caller":"traceutil/trace.go:171","msg":"trace[925553530] transaction","detail":"{read_only:false; response_revision:8606; number_of_response:1; }","duration":"326.5454ms","start":"2026-08-15T02:48:18.201381Z","end":"2026-08-15T02:48:18.527927Z","steps":["trace[925553530] 'process raft request' (duration: 326.220571ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:48:18.528103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-15T02:48:18.201369Z","time spent":"326.659994ms","remote":"127.0.0.1:38314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-15T02:48:22.919568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.54048ms","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-08-15T02:48:22.919655Z","caller":"traceutil/trace.go:171","msg":"trace[1083453593] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8630; }","duration":"135.679163ms","start":"2026-08-15T02:48:22.783958Z","end":"2026-08-15T02:48:22.919637Z","steps":["trace[1083453593] 'range keys from in-memory index tree' (duration: 135.285923ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:48:24.71941Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000022f7.wal"} {"level":"info","ts":"2026-08-15T02:48:31.297042Z","caller":"traceutil/trace.go:171","msg":"trace[819142385] linearizableReadLoop","detail":"{readStateIndex:9030; appliedIndex:9028; }","duration":"220.017201ms","start":"2026-08-15T02:48:31.077004Z","end":"2026-08-15T02:48:31.297021Z","steps":["trace[819142385] 'read index received' (duration: 33.850852ms)","trace[819142385] 'applied index is now lower than readState.Index' (duration: 186.165269ms)"],"step_count":2} {"level":"info","ts":"2026-08-15T02:48:31.297094Z","caller":"traceutil/trace.go:171","msg":"trace[2147468596] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8716; }","duration":"231.37988ms","start":"2026-08-15T02:48:31.065679Z","end":"2026-08-15T02:48:31.297059Z","steps":["trace[2147468596] 'process raft request' (duration: 231.151334ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:48:31.297147Z","caller":"traceutil/trace.go:171","msg":"trace[82267507] transaction","detail":"{read_only:false; response_revision:8717; number_of_response:1; }","duration":"219.448005ms","start":"2026-08-15T02:48:31.07769Z","end":"2026-08-15T02:48:31.297138Z","steps":["trace[82267507] 'process raft request' (duration: 219.27766ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:48:31.297387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.176173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-15T02:48:31.297454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.355774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-15T02:48:31.297485Z","caller":"traceutil/trace.go:171","msg":"trace[1635770534] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8717; }","duration":"139.419486ms","start":"2026-08-15T02:48:31.158056Z","end":"2026-08-15T02:48:31.297476Z","steps":["trace[1635770534] 'agreement among raft nodes before linearized reading' (duration: 139.361364ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:48:31.297472Z","caller":"traceutil/trace.go:171","msg":"trace[1935357482] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:8717; }","duration":"192.303155ms","start":"2026-08-15T02:48:31.105149Z","end":"2026-08-15T02:48:31.297452Z","steps":["trace[1935357482] 'agreement among raft nodes before linearized reading' (duration: 192.155171ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:48:31.2975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.477953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-6mxhb\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-08-15T02:48:31.297583Z","caller":"traceutil/trace.go:171","msg":"trace[1663824922] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-6mxhb; range_end:; response_count:1; response_revision:8717; }","duration":"220.598286ms","start":"2026-08-15T02:48:31.076962Z","end":"2026-08-15T02:48:31.29756Z","steps":["trace[1663824922] 'agreement among raft nodes before linearized reading' (duration: 220.36007ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:48:31.499018Z","caller":"traceutil/trace.go:171","msg":"trace[468709196] transaction","detail":"{read_only:false; response_revision:8718; number_of_response:1; }","duration":"192.540432ms","start":"2026-08-15T02:48:31.306437Z","end":"2026-08-15T02:48:31.498978Z","steps":["trace[468709196] 'process raft request' (duration: 192.356397ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:48:32.238866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.983285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-15T02:48:32.238943Z","caller":"traceutil/trace.go:171","msg":"trace[1099427424] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:8723; }","duration":"124.125979ms","start":"2026-08-15T02:48:32.114799Z","end":"2026-08-15T02:48:32.238925Z","steps":["trace[1099427424] 'count revisions from in-memory index tree' (duration: 123.887403ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:49:49.172164Z","caller":"traceutil/trace.go:171","msg":"trace[743147625] linearizableReadLoop","detail":"{readStateIndex:9803; appliedIndex:9802; }","duration":"159.726009ms","start":"2026-08-15T02:49:49.012417Z","end":"2026-08-15T02:49:49.172143Z","steps":["trace[743147625] 'read index received' (duration: 159.518182ms)","trace[743147625] 'applied index is now lower than readState.Index' (duration: 206.737µs)"],"step_count":2} {"level":"info","ts":"2026-08-15T02:49:49.172213Z","caller":"traceutil/trace.go:171","msg":"trace[865946687] transaction","detail":"{read_only:false; response_revision:9470; number_of_response:1; }","duration":"164.281793ms","start":"2026-08-15T02:49:49.007899Z","end":"2026-08-15T02:49:49.172181Z","steps":["trace[865946687] 'process raft request' (duration: 164.112788ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:49:49.172427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.991695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.192\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-15T02:49:49.172569Z","caller":"traceutil/trace.go:171","msg":"trace[1893980013] range","detail":"{range_begin:/registry/masterleases/199.19.213.192; range_end:; response_count:1; response_revision:9470; }","duration":"160.186721ms","start":"2026-08-15T02:49:49.012362Z","end":"2026-08-15T02:49:49.172548Z","steps":["trace[1893980013] 'agreement among raft nodes before linearized reading' (duration: 159.913774ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T02:49:49.172679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.724275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-15T02:49:49.172775Z","caller":"traceutil/trace.go:171","msg":"trace[1523855239] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9470; }","duration":"146.829288ms","start":"2026-08-15T02:49:49.025892Z","end":"2026-08-15T02:49:49.172721Z","steps":["trace[1523855239] 'agreement among raft nodes before linearized reading' (duration: 146.400367ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T02:50:14.218265Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"341a3703c39c1f5b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-15T02:50:14.224831Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-15T02:50:14.224904Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-15T02:52:25.866853Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8134} {"level":"info","ts":"2026-08-15T02:52:25.931437Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8134,"took":"62.146092ms","hash":3707487803,"current-db-size-bytes":58961920,"current-db-size":"59 MB","current-db-size-in-use-bytes":28459008,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-15T02:52:25.931562Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3707487803,"revision":8134,"compact-revision":6052} {"level":"info","ts":"2026-08-15T02:55:27.102694Z","caller":"traceutil/trace.go:171","msg":"trace[234027896] transaction","detail":"{read_only:false; response_revision:11897; number_of_response:1; }","duration":"110.923319ms","start":"2026-08-15T02:55:26.991739Z","end":"2026-08-15T02:55:27.102662Z","steps":["trace[234027896] 'process raft request' (duration: 82.945687ms)","trace[234027896] 'compare' (duration: 27.689864ms)"],"step_count":2} {"level":"info","ts":"2026-08-15T02:57:25.874183Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10493} {"level":"info","ts":"2026-08-15T02:57:25.955793Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10493,"took":"77.662937ms","hash":3558903935,"current-db-size-bytes":58961920,"current-db-size":"59 MB","current-db-size-in-use-bytes":26099712,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-08-15T02:57:25.955892Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3558903935,"revision":10493,"compact-revision":8134} {"level":"info","ts":"2026-08-15T03:01:21.598478Z","caller":"traceutil/trace.go:171","msg":"trace[1563201370] transaction","detail":"{read_only:false; response_revision:14273; number_of_response:1; }","duration":"102.138452ms","start":"2026-08-15T03:01:21.496304Z","end":"2026-08-15T03:01:21.598442Z","steps":["trace[1563201370] 'process raft request' (duration: 101.260749ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:02:11.665716Z","caller":"traceutil/trace.go:171","msg":"trace[1816346520] transaction","detail":"{read_only:false; response_revision:14578; number_of_response:1; }","duration":"126.702357ms","start":"2026-08-15T03:02:11.538981Z","end":"2026-08-15T03:02:11.665683Z","steps":["trace[1816346520] 'process raft request' (duration: 99.237235ms)","trace[1816346520] 'compare' (duration: 27.331659ms)"],"step_count":2} {"level":"info","ts":"2026-08-15T03:02:25.879977Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12690} {"level":"info","ts":"2026-08-15T03:02:25.955095Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12690,"took":"72.631385ms","hash":2635942660,"current-db-size-bytes":58961920,"current-db-size":"59 MB","current-db-size-in-use-bytes":27037696,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-08-15T03:02:25.955164Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2635942660,"revision":12690,"compact-revision":10493} {"level":"warn","ts":"2026-08-15T03:02:51.388505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.507244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-08-15T03:02:51.388588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.795953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-15T03:02:51.388639Z","caller":"traceutil/trace.go:171","msg":"trace[1150425664] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14991; }","duration":"213.70389ms","start":"2026-08-15T03:02:51.17491Z","end":"2026-08-15T03:02:51.388613Z","steps":["trace[1150425664] 'range keys from in-memory index tree' (duration: 213.35326ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:02:51.388707Z","caller":"traceutil/trace.go:171","msg":"trace[1905985117] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14991; }","duration":"216.974468ms","start":"2026-08-15T03:02:51.171706Z","end":"2026-08-15T03:02:51.388681Z","steps":["trace[1905985117] 'range keys from in-memory index tree' (duration: 216.596478ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:04:13.975007Z","caller":"traceutil/trace.go:171","msg":"trace[1699879483] transaction","detail":"{read_only:false; response_revision:15784; number_of_response:1; }","duration":"155.332624ms","start":"2026-08-15T03:04:13.819653Z","end":"2026-08-15T03:04:13.974985Z","steps":["trace[1699879483] 'process raft request' (duration: 133.023352ms)","trace[1699879483] 'compare' (duration: 21.826399ms)"],"step_count":2} {"level":"info","ts":"2026-08-15T03:07:25.897398Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14651} {"level":"info","ts":"2026-08-15T03:07:25.993349Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14651,"took":"91.324528ms","hash":1109551931,"current-db-size-bytes":58961920,"current-db-size":"59 MB","current-db-size-in-use-bytes":31916032,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-15T03:07:25.993421Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1109551931,"revision":14651,"compact-revision":12690} {"level":"info","ts":"2026-08-15T03:10:33.850716Z","caller":"traceutil/trace.go:171","msg":"trace[1472698820] transaction","detail":"{read_only:false; response_revision:18559; number_of_response:1; }","duration":"212.566187ms","start":"2026-08-15T03:10:33.638131Z","end":"2026-08-15T03:10:33.850697Z","steps":["trace[1472698820] 'process raft request' (duration: 212.32682ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:10:33.853362Z","caller":"traceutil/trace.go:171","msg":"trace[645967467] linearizableReadLoop","detail":"{readStateIndex:19201; appliedIndex:19199; }","duration":"138.082642ms","start":"2026-08-15T03:10:33.715259Z","end":"2026-08-15T03:10:33.853341Z","steps":["trace[645967467] 'read index received' (duration: 135.180263ms)","trace[645967467] 'applied index is now lower than readState.Index' (duration: 2.901149ms)"],"step_count":2} {"level":"info","ts":"2026-08-15T03:10:33.853592Z","caller":"traceutil/trace.go:171","msg":"trace[117346929] transaction","detail":"{read_only:false; response_revision:18560; number_of_response:1; }","duration":"189.032421ms","start":"2026-08-15T03:10:33.664524Z","end":"2026-08-15T03:10:33.853556Z","steps":["trace[117346929] 'process raft request' (duration: 188.727283ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T03:10:33.853641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.37009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-08-15T03:10:33.853672Z","caller":"traceutil/trace.go:171","msg":"trace[1435778205] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18560; }","duration":"138.464843ms","start":"2026-08-15T03:10:33.715197Z","end":"2026-08-15T03:10:33.853662Z","steps":["trace[1435778205] 'agreement among raft nodes before linearized reading' (duration: 138.324539ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:10:41.072527Z","caller":"traceutil/trace.go:171","msg":"trace[711893053] linearizableReadLoop","detail":"{readStateIndex:19242; appliedIndex:19241; }","duration":"262.389015ms","start":"2026-08-15T03:10:40.81012Z","end":"2026-08-15T03:10:41.072509Z","steps":["trace[711893053] 'read index received' (duration: 262.266992ms)","trace[711893053] 'applied index is now lower than readState.Index' (duration: 121.153µs)"],"step_count":2} {"level":"warn","ts":"2026-08-15T03:10:41.072683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.549299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-wzfg7\" ","response":"range_response_count:1 size:9792"} {"level":"info","ts":"2026-08-15T03:10:41.072604Z","caller":"traceutil/trace.go:171","msg":"trace[490156914] transaction","detail":"{read_only:false; response_revision:18599; number_of_response:1; }","duration":"331.615005ms","start":"2026-08-15T03:10:40.740944Z","end":"2026-08-15T03:10:41.072559Z","steps":["trace[490156914] 'process raft request' (duration: 331.369899ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T03:10:41.072876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-15T03:10:40.740903Z","time spent":"331.871902ms","remote":"127.0.0.1:38232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20864,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-15T03:10:41.072706Z","caller":"traceutil/trace.go:171","msg":"trace[2009899706] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-wzfg7; range_end:; response_count:1; response_revision:18599; }","duration":"262.627531ms","start":"2026-08-15T03:10:40.810071Z","end":"2026-08-15T03:10:41.072699Z","steps":["trace[2009899706] 'agreement among raft nodes before linearized reading' (duration: 262.510178ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:10:41.137129Z","caller":"traceutil/trace.go:171","msg":"trace[1602572357] transaction","detail":"{read_only:false; response_revision:18600; number_of_response:1; }","duration":"258.057845ms","start":"2026-08-15T03:10:40.87904Z","end":"2026-08-15T03:10:41.137097Z","steps":["trace[1602572357] 'process raft request' (duration: 241.388548ms)","trace[1602572357] 'compare' (duration: 16.464972ms)"],"step_count":2} {"level":"info","ts":"2026-08-15T03:10:41.137365Z","caller":"traceutil/trace.go:171","msg":"trace[82588800] transaction","detail":"{read_only:false; response_revision:18601; number_of_response:1; }","duration":"258.20896ms","start":"2026-08-15T03:10:40.879127Z","end":"2026-08-15T03:10:41.137336Z","steps":["trace[82588800] 'process raft request' (duration: 257.915292ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:10:41.137587Z","caller":"traceutil/trace.go:171","msg":"trace[1645659021] transaction","detail":"{read_only:false; response_revision:18603; number_of_response:1; }","duration":"258.328123ms","start":"2026-08-15T03:10:40.879227Z","end":"2026-08-15T03:10:41.137555Z","steps":["trace[1645659021] 'process raft request' (duration: 258.196359ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:10:41.137562Z","caller":"traceutil/trace.go:171","msg":"trace[250200649] transaction","detail":"{read_only:false; response_revision:18602; number_of_response:1; }","duration":"258.381404ms","start":"2026-08-15T03:10:40.879156Z","end":"2026-08-15T03:10:41.137537Z","steps":["trace[250200649] 'process raft request' (duration: 258.092967ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:11:47.974913Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"341a3703c39c1f5b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-15T03:11:47.983789Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-15T03:11:47.983915Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-15T03:12:25.919113Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17146} {"level":"info","ts":"2026-08-15T03:12:26.020104Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17146,"took":"98.261497ms","hash":3377330456,"current-db-size-bytes":58961920,"current-db-size":"59 MB","current-db-size-in-use-bytes":37457920,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-08-15T03:12:26.020165Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3377330456,"revision":17146,"compact-revision":14651} {"level":"info","ts":"2026-08-15T03:12:31.664247Z","caller":"traceutil/trace.go:171","msg":"trace[466803156] transaction","detail":"{read_only:false; response_revision:19667; number_of_response:1; }","duration":"111.547986ms","start":"2026-08-15T03:12:31.552678Z","end":"2026-08-15T03:12:31.664226Z","steps":["trace[466803156] 'process raft request' (duration: 111.005321ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:12:31.664371Z","caller":"traceutil/trace.go:171","msg":"trace[197201511] transaction","detail":"{read_only:false; response_revision:19668; number_of_response:1; }","duration":"101.013643ms","start":"2026-08-15T03:12:31.56335Z","end":"2026-08-15T03:12:31.664364Z","steps":["trace[197201511] 'process raft request' (duration: 100.451378ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:16:48.439051Z","caller":"traceutil/trace.go:171","msg":"trace[635223817] transaction","detail":"{read_only:false; response_revision:21390; number_of_response:1; }","duration":"137.267872ms","start":"2026-08-15T03:16:48.301748Z","end":"2026-08-15T03:16:48.439016Z","steps":["trace[635223817] 'process raft request' (duration: 137.036166ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:16:48.447206Z","caller":"traceutil/trace.go:171","msg":"trace[625912927] transaction","detail":"{read_only:false; response_revision:21391; number_of_response:1; }","duration":"142.642581ms","start":"2026-08-15T03:16:48.304524Z","end":"2026-08-15T03:16:48.447167Z","steps":["trace[625912927] 'process raft request' (duration: 142.468647ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:16:53.921209Z","caller":"traceutil/trace.go:171","msg":"trace[897535502] transaction","detail":"{read_only:false; response_revision:21419; number_of_response:1; }","duration":"169.968639ms","start":"2026-08-15T03:16:53.751212Z","end":"2026-08-15T03:16:53.921181Z","steps":["trace[897535502] 'process raft request' (duration: 169.811895ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:16:54.935724Z","caller":"traceutil/trace.go:171","msg":"trace[2000287059] linearizableReadLoop","detail":"{readStateIndex:22165; appliedIndex:22160; }","duration":"211.229206ms","start":"2026-08-15T03:16:54.72447Z","end":"2026-08-15T03:16:54.935699Z","steps":["trace[2000287059] 'read index received' (duration: 125.089087ms)","trace[2000287059] 'applied index is now lower than readState.Index' (duration: 86.138809ms)"],"step_count":2} {"level":"info","ts":"2026-08-15T03:16:54.935774Z","caller":"traceutil/trace.go:171","msg":"trace[632643909] transaction","detail":"{read_only:false; response_revision:21423; number_of_response:1; }","duration":"371.038482ms","start":"2026-08-15T03:16:54.564703Z","end":"2026-08-15T03:16:54.935741Z","steps":["trace[632643909] 'process raft request' (duration: 284.880794ms)","trace[632643909] 'compare' (duration: 85.521812ms)"],"step_count":2} {"level":"warn","ts":"2026-08-15T03:16:54.935914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-15T03:16:54.564684Z","time spent":"371.154405ms","remote":"127.0.0.1:38314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-15T03:16:54.935936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.463273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" ","response":"range_response_count:1 size:1864"} {"level":"info","ts":"2026-08-15T03:16:54.935973Z","caller":"traceutil/trace.go:171","msg":"trace[572061174] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0; range_end:; response_count:1; response_revision:21427; }","duration":"211.561875ms","start":"2026-08-15T03:16:54.724399Z","end":"2026-08-15T03:16:54.935961Z","steps":["trace[572061174] 'agreement among raft nodes before linearized reading' (duration: 211.394241ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:16:54.93617Z","caller":"traceutil/trace.go:171","msg":"trace[1918059189] transaction","detail":"{read_only:false; response_revision:21424; number_of_response:1; }","duration":"370.713694ms","start":"2026-08-15T03:16:54.565444Z","end":"2026-08-15T03:16:54.936158Z","steps":["trace[1918059189] 'process raft request' (duration: 370.006466ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T03:16:54.936252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-15T03:16:54.565418Z","time spent":"370.777395ms","remote":"127.0.0.1:38314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-15T03:16:54.936302Z","caller":"traceutil/trace.go:171","msg":"trace[660606992] transaction","detail":"{read_only:false; response_revision:21425; number_of_response:1; }","duration":"282.171922ms","start":"2026-08-15T03:16:54.654118Z","end":"2026-08-15T03:16:54.93629Z","steps":["trace[660606992] 'process raft request' (duration: 281.413503ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:16:54.936408Z","caller":"traceutil/trace.go:171","msg":"trace[1001098406] transaction","detail":"{read_only:false; response_revision:21427; number_of_response:1; }","duration":"275.418488ms","start":"2026-08-15T03:16:54.660977Z","end":"2026-08-15T03:16:54.936396Z","steps":["trace[1001098406] 'process raft request' (duration: 274.681919ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:16:54.936486Z","caller":"traceutil/trace.go:171","msg":"trace[1551142991] transaction","detail":"{read_only:false; response_revision:21426; number_of_response:1; }","duration":"280.323396ms","start":"2026-08-15T03:16:54.656151Z","end":"2026-08-15T03:16:54.936474Z","steps":["trace[1551142991] 'process raft request' (duration: 279.470063ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T03:16:55.210904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.564238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-08-15T03:16:55.210976Z","caller":"traceutil/trace.go:171","msg":"trace[47335327] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:21427; }","duration":"169.686972ms","start":"2026-08-15T03:16:55.041273Z","end":"2026-08-15T03:16:55.21096Z","steps":["trace[47335327] 'range keys from in-memory index tree' (duration: 169.368993ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:17:25.940402Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19638} {"level":"info","ts":"2026-08-15T03:17:26.101928Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19638,"took":"156.229404ms","hash":2843451104,"current-db-size-bytes":58961920,"current-db-size":"59 MB","current-db-size-in-use-bytes":29962240,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-15T03:17:26.102002Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2843451104,"revision":19638,"compact-revision":17146} {"level":"info","ts":"2026-08-15T03:20:55.963169Z","caller":"traceutil/trace.go:171","msg":"trace[1611086576] linearizableReadLoop","detail":"{readStateIndex:24741; appliedIndex:24740; }","duration":"113.178798ms","start":"2026-08-15T03:20:55.84996Z","end":"2026-08-15T03:20:55.963139Z","steps":["trace[1611086576] 'read index received' (duration: 113.078366ms)","trace[1611086576] 'applied index is now lower than readState.Index' (duration: 98.662µs)"],"step_count":2} {"level":"info","ts":"2026-08-15T03:20:55.963287Z","caller":"traceutil/trace.go:171","msg":"trace[50781600] transaction","detail":"{read_only:false; response_revision:23924; number_of_response:1; }","duration":"126.062692ms","start":"2026-08-15T03:20:55.837182Z","end":"2026-08-15T03:20:55.963245Z","steps":["trace[50781600] 'process raft request' (duration: 125.781845ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T03:20:55.963419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.410705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-15T03:20:55.963484Z","caller":"traceutil/trace.go:171","msg":"trace[1797856733] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:23924; }","duration":"113.558799ms","start":"2026-08-15T03:20:55.84991Z","end":"2026-08-15T03:20:55.963469Z","steps":["trace[1797856733] 'agreement among raft nodes before linearized reading' (duration: 113.389044ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:20:56.00933Z","caller":"traceutil/trace.go:171","msg":"trace[115922371] transaction","detail":"{read_only:false; response_revision:23926; number_of_response:1; }","duration":"154.253322ms","start":"2026-08-15T03:20:55.855025Z","end":"2026-08-15T03:20:56.009278Z","steps":["trace[115922371] 'process raft request' (duration: 154.092758ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:20:56.00934Z","caller":"traceutil/trace.go:171","msg":"trace[1568940322] transaction","detail":"{read_only:false; response_revision:23925; number_of_response:1; }","duration":"154.396055ms","start":"2026-08-15T03:20:55.85486Z","end":"2026-08-15T03:20:56.009256Z","steps":["trace[1568940322] 'process raft request' (duration: 154.133249ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T03:20:56.009565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.008991ms","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-08-15T03:20:56.009614Z","caller":"traceutil/trace.go:171","msg":"trace[1803455401] transaction","detail":"{read_only:false; response_revision:23927; number_of_response:1; }","duration":"153.196105ms","start":"2026-08-15T03:20:55.856403Z","end":"2026-08-15T03:20:56.009599Z","steps":["trace[1803455401] 'process raft request' (duration: 152.756523ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:20:56.009651Z","caller":"traceutil/trace.go:171","msg":"trace[1259120261] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23928; }","duration":"114.134484ms","start":"2026-08-15T03:20:55.895501Z","end":"2026-08-15T03:20:56.009636Z","steps":["trace[1259120261] 'agreement among raft nodes before linearized reading' (duration: 113.862207ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:20:56.312595Z","caller":"traceutil/trace.go:171","msg":"trace[1827819421] linearizableReadLoop","detail":"{readStateIndex:24746; appliedIndex:24745; }","duration":"244.237871ms","start":"2026-08-15T03:20:56.068331Z","end":"2026-08-15T03:20:56.312569Z","steps":["trace[1827819421] 'read index received' (duration: 243.952394ms)","trace[1827819421] 'applied index is now lower than readState.Index' (duration: 284.137µs)"],"step_count":2} {"level":"info","ts":"2026-08-15T03:20:56.312686Z","caller":"traceutil/trace.go:171","msg":"trace[1966247799] transaction","detail":"{read_only:false; response_revision:23929; number_of_response:1; }","duration":"297.611922ms","start":"2026-08-15T03:20:56.015027Z","end":"2026-08-15T03:20:56.312639Z","steps":["trace[1966247799] 'process raft request' (duration: 297.344815ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T03:20:56.312879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.410649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-15T03:20:56.312898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.945834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-15T03:20:56.312976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.631591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/openstackclustertemplates.infrastructure.cluster.x-k8s.io\" ","response":"range_response_count:1 size:70568"} {"level":"info","ts":"2026-08-15T03:20:56.313095Z","caller":"traceutil/trace.go:171","msg":"trace[1401936638] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/openstackclustertemplates.infrastructure.cluster.x-k8s.io; range_end:; response_count:1; response_revision:23929; }","duration":"244.799315ms","start":"2026-08-15T03:20:56.06827Z","end":"2026-08-15T03:20:56.31307Z","steps":["trace[1401936638] 'agreement among raft nodes before linearized reading' (duration: 244.410985ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:20:56.313048Z","caller":"traceutil/trace.go:171","msg":"trace[994536629] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:23929; }","duration":"154.141569ms","start":"2026-08-15T03:20:56.158892Z","end":"2026-08-15T03:20:56.313033Z","steps":["trace[994536629] 'agreement among raft nodes before linearized reading' (duration: 153.919413ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:20:56.312959Z","caller":"traceutil/trace.go:171","msg":"trace[1345250693] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:23929; }","duration":"214.545273ms","start":"2026-08-15T03:20:56.098396Z","end":"2026-08-15T03:20:56.312941Z","steps":["trace[1345250693] 'agreement among raft nodes before linearized reading' (duration: 214.41135ms)"],"step_count":1} {"level":"warn","ts":"2026-08-15T03:20:56.313207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.068768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-08-15T03:20:56.313323Z","caller":"traceutil/trace.go:171","msg":"trace[964780423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:23929; }","duration":"183.257082ms","start":"2026-08-15T03:20:56.130022Z","end":"2026-08-15T03:20:56.313279Z","steps":["trace[964780423] 'agreement among raft nodes before linearized reading' (duration: 182.865572ms)"],"step_count":1} {"level":"info","ts":"2026-08-15T03:22:25.948315Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21754} {"level":"info","ts":"2026-08-15T03:22:26.062464Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21754,"took":"109.468393ms","hash":186102009,"current-db-size-bytes":59805696,"current-db-size":"60 MB","current-db-size-in-use-bytes":43372544,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-08-15T03:22:26.062528Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":186102009,"revision":21754,"compact-revision":19638} {"level":"info","ts":"2026-08-15T03:26:59.156236Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006cbf.wal"} {"level":"info","ts":"2026-08-15T03:27:25.956224Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24881} {"level":"info","ts":"2026-08-15T03:27:26.094774Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24881,"took":"134.236654ms","hash":2861547209,"current-db-size-bytes":59805696,"current-db-size":"60 MB","current-db-size-in-use-bytes":31326208,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-15T03:27:26.094862Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2861547209,"revision":24881,"compact-revision":21754}