{"level":"warn","ts":"2026-10-26T19:22:49.230245Z","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-26T19:22:49.230338Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.167: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.167:2380","--initial-cluster=instance=https://162.253.55.167:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.167:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.167: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-26T19:22:49.230394Z","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-26T19:22:49.230404Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.167:2380"]} {"level":"info","ts":"2026-10-26T19:22:49.230425Z","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-26T19:22:49.231033Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.167:2379"]} {"level":"info","ts":"2026-10-26T19:22:49.231122Z","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.167:2380"],"listen-peer-urls":["https://162.253.55.167:2380"],"advertise-client-urls":["https://162.253.55.167:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.167:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.167: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-26T19:22:49.235713Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.358675ms"} {"level":"info","ts":"2026-10-26T19:22:49.243817Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"83287f3a81241ad4","cluster-id":"185ed9b8ed398b9a"} {"level":"info","ts":"2026-10-26T19:22:49.244006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 switched to configuration voters=()"} {"level":"info","ts":"2026-10-26T19:22:49.244047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 became follower at term 0"} {"level":"info","ts":"2026-10-26T19:22:49.244066Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 83287f3a81241ad4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-26T19:22:49.244087Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 became follower at term 1"} {"level":"info","ts":"2026-10-26T19:22:49.244155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 switched to configuration voters=(9450943707288443604)"} {"level":"warn","ts":"2026-10-26T19:22:49.250872Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-26T19:22:49.252763Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-26T19:22:49.254582Z","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-26T19:22:49.256976Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"83287f3a81241ad4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-26T19:22:49.257196Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"83287f3a81241ad4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-26T19:22:49.257316Z","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-26T19:22:49.257368Z","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-26T19:22:49.257375Z","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-26T19:22:49.260306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 switched to configuration voters=(9450943707288443604)"} {"level":"info","ts":"2026-10-26T19:22:49.260438Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"185ed9b8ed398b9a","local-member-id":"83287f3a81241ad4","added-peer-id":"83287f3a81241ad4","added-peer-peer-urls":["https://162.253.55.167:2380"]} {"level":"info","ts":"2026-10-26T19:22:49.269531Z","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-26T19:22:49.269706Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.167:2380"} {"level":"info","ts":"2026-10-26T19:22:49.269808Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"83287f3a81241ad4","initial-advertise-peer-urls":["https://162.253.55.167:2380"],"listen-peer-urls":["https://162.253.55.167:2380"],"advertise-client-urls":["https://162.253.55.167:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.167:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-26T19:22:49.269871Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-26T19:22:49.269847Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.167:2380"} {"level":"info","ts":"2026-10-26T19:22:49.644602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 is starting a new election at term 1"} {"level":"info","ts":"2026-10-26T19:22:49.644676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-26T19:22:49.644712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 received MsgPreVoteResp from 83287f3a81241ad4 at term 1"} {"level":"info","ts":"2026-10-26T19:22:49.644732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 became candidate at term 2"} {"level":"info","ts":"2026-10-26T19:22:49.644742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 received MsgVoteResp from 83287f3a81241ad4 at term 2"} {"level":"info","ts":"2026-10-26T19:22:49.644759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"83287f3a81241ad4 became leader at term 2"} {"level":"info","ts":"2026-10-26T19:22:49.644771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 83287f3a81241ad4 elected leader 83287f3a81241ad4 at term 2"} {"level":"info","ts":"2026-10-26T19:22:49.645885Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"83287f3a81241ad4","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.167:2379]}","request-path":"/0/members/83287f3a81241ad4/attributes","cluster-id":"185ed9b8ed398b9a","publish-timeout":"7s"} {"level":"info","ts":"2026-10-26T19:22:49.646045Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-26T19:22:49.646181Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-26T19:22:49.64627Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-26T19:22:49.646192Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T19:22:49.646327Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-26T19:22:49.647588Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"185ed9b8ed398b9a","local-member-id":"83287f3a81241ad4","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T19:22:49.647719Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T19:22:49.647756Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-26T19:22:49.649511Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.167:2379"} {"level":"info","ts":"2026-10-26T19:22:49.649798Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-10-26T19:23:08.572815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.386266ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-26T19:23:08.69539Z","caller":"traceutil/trace.go:171","msg":"trace[140454743] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"110.770089ms","start":"2026-10-26T19:23:08.584587Z","end":"2026-10-26T19:23:08.695357Z","steps":["trace[140454743] 'process raft request' (duration: 110.569464ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:23:41.838519Z","caller":"traceutil/trace.go:171","msg":"trace[2133833322] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"262.414672ms","start":"2026-10-26T19:23:41.576076Z","end":"2026-10-26T19:23:41.838491Z","steps":["trace[2133833322] 'process raft request' (duration: 261.347387ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:23:42.215595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.300819ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T19:23:42.215981Z","caller":"traceutil/trace.go:171","msg":"trace[1425392281] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"308.777023ms","start":"2026-10-26T19:23:41.907168Z","end":"2026-10-26T19:23:42.215946Z","steps":["trace[1425392281] 'process raft request' (duration: 308.628649ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:23:42.215881Z","caller":"traceutil/trace.go:171","msg":"trace[1735376718] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"333.419578ms","start":"2026-10-26T19:23:41.882405Z","end":"2026-10-26T19:23:42.215824Z","steps":["trace[1735376718] 'process raft request' (duration: 86.956892ms)","trace[1735376718] 'compare' (duration: 245.132884ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:23:42.215956Z","caller":"traceutil/trace.go:171","msg":"trace[36771127] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"328.616912ms","start":"2026-10-26T19:23:41.887302Z","end":"2026-10-26T19:23:42.215919Z","steps":["trace[36771127] 'read index received' (duration: 82.053633ms)","trace[36771127] 'applied index is now lower than readState.Index' (duration: 246.560709ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:23:42.216102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:23:41.907135Z","time spent":"308.903666ms","remote":"127.0.0.1:60230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-26T19:23:42.216243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.904619ms","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-26T19:23:42.216306Z","caller":"traceutil/trace.go:171","msg":"trace[233781234] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:649; }","duration":"329.062843ms","start":"2026-10-26T19:23:41.887227Z","end":"2026-10-26T19:23:42.21629Z","steps":["trace[233781234] 'agreement among raft nodes before linearized reading' (duration: 328.804207ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:23:42.216342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:23:41.887172Z","time spent":"329.159895ms","remote":"127.0.0.1:60142","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":"warn","ts":"2026-10-26T19:23:42.216632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:23:41.882371Z","time spent":"333.683585ms","remote":"127.0.0.1:60142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T19:23:42.234713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.54883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-26T19:23:42.234795Z","caller":"traceutil/trace.go:171","msg":"trace[152070668] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:650; }","duration":"112.687963ms","start":"2026-10-26T19:23:42.122091Z","end":"2026-10-26T19:23:42.234779Z","steps":["trace[152070668] 'agreement among raft nodes before linearized reading' (duration: 112.522319ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:23:42.234948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.868296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-26T19:23:42.235004Z","caller":"traceutil/trace.go:171","msg":"trace[1968922702] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:650; }","duration":"277.927077ms","start":"2026-10-26T19:23:41.957061Z","end":"2026-10-26T19:23:42.234988Z","steps":["trace[1968922702] 'agreement among raft nodes before linearized reading' (duration: 277.774144ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:23:42.677832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.891243ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T19:23:42.678005Z","caller":"traceutil/trace.go:171","msg":"trace[2086501703] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"438.741685ms","start":"2026-10-26T19:23:42.239247Z","end":"2026-10-26T19:23:42.677989Z","steps":["trace[2086501703] 'process raft request' (duration: 438.674463ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:23:42.678089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:23:42.239235Z","time spent":"438.811526ms","remote":"127.0.0.1:60142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T19:23:42.678421Z","caller":"traceutil/trace.go:171","msg":"trace[1804230617] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"439.461401ms","start":"2026-10-26T19:23:42.238895Z","end":"2026-10-26T19:23:42.678356Z","steps":["trace[1804230617] 'process raft request' (duration: 288.967854ms)","trace[1804230617] 'compare' (duration: 149.748749ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:23:42.678689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:23:42.23885Z","time spent":"439.712467ms","remote":"127.0.0.1:60142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T19:24:28.787032Z","caller":"traceutil/trace.go:171","msg":"trace[488761165] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"144.272207ms","start":"2026-10-26T19:24:28.642728Z","end":"2026-10-26T19:24:28.787Z","steps":["trace[488761165] 'process raft request' (duration: 144.075762ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:24:28.812968Z","caller":"traceutil/trace.go:171","msg":"trace[599935202] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"166.994136ms","start":"2026-10-26T19:24:28.64594Z","end":"2026-10-26T19:24:28.812934Z","steps":["trace[599935202] 'process raft request' (duration: 166.564236ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:25:18.936214Z","caller":"traceutil/trace.go:171","msg":"trace[1872916338] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"172.828004ms","start":"2026-10-26T19:25:18.763331Z","end":"2026-10-26T19:25:18.936159Z","steps":["trace[1872916338] 'process raft request' (duration: 172.535037ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:25:18.936379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.096364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8756db63-897f-4bce-a17a-31c6e12c7cf6\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-10-26T19:25:18.936477Z","caller":"traceutil/trace.go:171","msg":"trace[2103432068] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8756db63-897f-4bce-a17a-31c6e12c7cf6; range_end:; response_count:1; response_revision:1893; }","duration":"142.312669ms","start":"2026-10-26T19:25:18.794149Z","end":"2026-10-26T19:25:18.936462Z","steps":["trace[2103432068] 'agreement among raft nodes before linearized reading' (duration: 142.128395ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:25:18.936204Z","caller":"traceutil/trace.go:171","msg":"trace[1266902786] linearizableReadLoop","detail":"{readStateIndex:1969; appliedIndex:1968; }","duration":"141.851858ms","start":"2026-10-26T19:25:18.794258Z","end":"2026-10-26T19:25:18.93611Z","steps":["trace[1266902786] 'read index received' (duration: 141.716395ms)","trace[1266902786] 'applied index is now lower than readState.Index' (duration: 134.113µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:25:19.019442Z","caller":"traceutil/trace.go:171","msg":"trace[1520465970] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"136.753876ms","start":"2026-10-26T19:25:18.882632Z","end":"2026-10-26T19:25:19.019386Z","steps":["trace[1520465970] 'process raft request' (duration: 107.619494ms)","trace[1520465970] 'compare' (duration: 28.961237ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:25:19.306137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.674906ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T19:25:19.306358Z","caller":"traceutil/trace.go:171","msg":"trace[352876097] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"206.541207ms","start":"2026-10-26T19:25:19.099755Z","end":"2026-10-26T19:25:19.306297Z","steps":["trace[352876097] 'process raft request' (duration: 78.564223ms)","trace[352876097] 'compare' (duration: 127.527953ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:25:19.306307Z","caller":"traceutil/trace.go:171","msg":"trace[1638271737] linearizableReadLoop","detail":"{readStateIndex:1972; appliedIndex:1970; }","duration":"204.998939ms","start":"2026-10-26T19:25:19.101283Z","end":"2026-10-26T19:25:19.306282Z","steps":["trace[1638271737] 'read index received' (duration: 5.679927ms)","trace[1638271737] 'applied index is now lower than readState.Index' (duration: 199.317042ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:25:19.306611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.311528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-26T19:25:19.306675Z","caller":"traceutil/trace.go:171","msg":"trace[1359787962] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1896; }","duration":"205.410769ms","start":"2026-10-26T19:25:19.101247Z","end":"2026-10-26T19:25:19.306658Z","steps":["trace[1359787962] 'agreement among raft nodes before linearized reading' (duration: 205.225675ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:26:59.854474Z","caller":"traceutil/trace.go:171","msg":"trace[468179979] transaction","detail":"{read_only:false; response_revision:2667; number_of_response:1; }","duration":"105.158598ms","start":"2026-10-26T19:26:59.749289Z","end":"2026-10-26T19:26:59.854447Z","steps":["trace[468179979] 'process raft request' (duration: 104.995934ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:27:38.286359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.174766ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T19:27:38.286514Z","caller":"traceutil/trace.go:171","msg":"trace[2027527638] linearizableReadLoop","detail":"{readStateIndex:3015; appliedIndex:3014; }","duration":"182.056121ms","start":"2026-10-26T19:27:38.104433Z","end":"2026-10-26T19:27:38.286489Z","steps":["trace[2027527638] 'read index received' (duration: 24.67µs)","trace[2027527638] 'applied index is now lower than readState.Index' (duration: 182.030001ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:27:38.286748Z","caller":"traceutil/trace.go:171","msg":"trace[710462787] transaction","detail":"{read_only:false; response_revision:2902; number_of_response:1; }","duration":"191.111788ms","start":"2026-10-26T19:27:38.095406Z","end":"2026-10-26T19:27:38.286518Z","steps":["trace[710462787] 'compare' (duration: 185.014832ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:27:38.28677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.046447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"} {"level":"info","ts":"2026-10-26T19:27:38.286814Z","caller":"traceutil/trace.go:171","msg":"trace[1934257519] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2902; }","duration":"181.150989ms","start":"2026-10-26T19:27:38.105652Z","end":"2026-10-26T19:27:38.286803Z","steps":["trace[1934257519] 'agreement among raft nodes before linearized reading' (duration: 180.983295ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:27:38.286935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.076529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-10-26T19:27:38.287044Z","caller":"traceutil/trace.go:171","msg":"trace[459855879] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2902; }","duration":"142.258493ms","start":"2026-10-26T19:27:38.144761Z","end":"2026-10-26T19:27:38.287019Z","steps":["trace[459855879] 'agreement among raft nodes before linearized reading' (duration: 141.912024ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:27:38.286985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.505383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-26T19:27:38.287259Z","caller":"traceutil/trace.go:171","msg":"trace[808133098] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2902; }","duration":"182.81897ms","start":"2026-10-26T19:27:38.104409Z","end":"2026-10-26T19:27:38.287228Z","steps":["trace[808133098] 'agreement among raft nodes before linearized reading' (duration: 182.210585ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:32:24.290751Z","caller":"traceutil/trace.go:171","msg":"trace[781233959] transaction","detail":"{read_only:false; response_revision:5329; number_of_response:1; }","duration":"116.606406ms","start":"2026-10-26T19:32:24.174107Z","end":"2026-10-26T19:32:24.290714Z","steps":["trace[781233959] 'process raft request' (duration: 116.398101ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:32:24.382753Z","caller":"traceutil/trace.go:171","msg":"trace[1768438495] linearizableReadLoop","detail":"{readStateIndex:5537; appliedIndex:5535; }","duration":"158.277566ms","start":"2026-10-26T19:32:24.224434Z","end":"2026-10-26T19:32:24.382711Z","steps":["trace[1768438495] 'read index received' (duration: 66.097672ms)","trace[1768438495] 'applied index is now lower than readState.Index' (duration: 92.178464ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:32:24.382818Z","caller":"traceutil/trace.go:171","msg":"trace[1777796451] transaction","detail":"{read_only:false; response_revision:5330; number_of_response:1; }","duration":"167.133911ms","start":"2026-10-26T19:32:24.215631Z","end":"2026-10-26T19:32:24.382765Z","steps":["trace[1777796451] 'process raft request' (duration: 166.851574ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:32:24.383152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.676426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e6bad834-cbfb-4431-bc56-2ca63805b4be\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-26T19:32:24.383217Z","caller":"traceutil/trace.go:171","msg":"trace[1491798137] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e6bad834-cbfb-4431-bc56-2ca63805b4be; range_end:; response_count:1; response_revision:5330; }","duration":"158.809789ms","start":"2026-10-26T19:32:24.224389Z","end":"2026-10-26T19:32:24.383199Z","steps":["trace[1491798137] 'agreement among raft nodes before linearized reading' (duration: 158.482501ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:32:35.05702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.20459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3684"} {"level":"info","ts":"2026-10-26T19:32:35.057174Z","caller":"traceutil/trace.go:171","msg":"trace[1354590811] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5529; }","duration":"124.416146ms","start":"2026-10-26T19:32:34.932722Z","end":"2026-10-26T19:32:35.057138Z","steps":["trace[1354590811] 'range keys from in-memory index tree' (duration: 123.594776ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:32:40.482567Z","caller":"traceutil/trace.go:171","msg":"trace[1301199613] transaction","detail":"{read_only:false; response_revision:5611; number_of_response:1; }","duration":"122.634352ms","start":"2026-10-26T19:32:40.35989Z","end":"2026-10-26T19:32:40.482525Z","steps":["trace[1301199613] 'process raft request' (duration: 122.347665ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:32:48.368323Z","caller":"traceutil/trace.go:171","msg":"trace[1159074749] transaction","detail":"{read_only:false; response_revision:5769; number_of_response:1; }","duration":"116.940454ms","start":"2026-10-26T19:32:48.251339Z","end":"2026-10-26T19:32:48.368279Z","steps":["trace[1159074749] 'process raft request' (duration: 114.927175ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:32:49.91853Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2961} {"level":"info","ts":"2026-10-26T19:32:49.998597Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2961,"took":"77.996981ms","hash":3631750295,"current-db-size-bytes":56176640,"current-db-size":"56 MB","current-db-size-in-use-bytes":31891456,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-26T19:32:49.998682Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3631750295,"revision":2961,"compact-revision":-1} {"level":"warn","ts":"2026-10-26T19:32:50.771212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.457052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-26T19:32:50.771349Z","caller":"traceutil/trace.go:171","msg":"trace[1440924247] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5786; }","duration":"156.685068ms","start":"2026-10-26T19:32:50.614636Z","end":"2026-10-26T19:32:50.771321Z","steps":["trace[1440924247] 'count revisions from in-memory index tree' (duration: 156.340389ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:37:49.924942Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5778} {"level":"info","ts":"2026-10-26T19:37:50.015351Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5778,"took":"88.321151ms","hash":190313372,"current-db-size-bytes":56176640,"current-db-size":"56 MB","current-db-size-in-use-bytes":26734592,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-26T19:37:50.015419Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":190313372,"revision":5778,"compact-revision":2961} {"level":"info","ts":"2026-10-26T19:39:12.520129Z","caller":"traceutil/trace.go:171","msg":"trace[2136178019] linearizableReadLoop","detail":"{readStateIndex:9019; appliedIndex:9018; }","duration":"142.798649ms","start":"2026-10-26T19:39:12.377308Z","end":"2026-10-26T19:39:12.520106Z","steps":["trace[2136178019] 'read index received' (duration: 142.713837ms)","trace[2136178019] 'applied index is now lower than readState.Index' (duration: 83.982µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:39:12.520185Z","caller":"traceutil/trace.go:171","msg":"trace[202387763] transaction","detail":"{read_only:false; response_revision:8705; number_of_response:1; }","duration":"146.256813ms","start":"2026-10-26T19:39:12.373902Z","end":"2026-10-26T19:39:12.520158Z","steps":["trace[202387763] 'process raft request' (duration: 146.042758ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:39:12.520441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.102726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-26T19:39:12.520548Z","caller":"traceutil/trace.go:171","msg":"trace[459939943] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8705; }","duration":"143.25268ms","start":"2026-10-26T19:39:12.377269Z","end":"2026-10-26T19:39:12.520521Z","steps":["trace[459939943] 'agreement among raft nodes before linearized reading' (duration: 142.941223ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:39:12.530746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.313204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T19:39:12.530801Z","caller":"traceutil/trace.go:171","msg":"trace[738852] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:8706; }","duration":"139.393356ms","start":"2026-10-26T19:39:12.391393Z","end":"2026-10-26T19:39:12.530786Z","steps":["trace[738852] 'agreement among raft nodes before linearized reading' (duration: 139.275523ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:39:13.099493Z","caller":"traceutil/trace.go:171","msg":"trace[365093203] transaction","detail":"{read_only:false; response_revision:8708; number_of_response:1; }","duration":"135.801199ms","start":"2026-10-26T19:39:12.963662Z","end":"2026-10-26T19:39:13.099463Z","steps":["trace[365093203] 'process raft request' (duration: 135.594864ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:39:13.802534Z","caller":"traceutil/trace.go:171","msg":"trace[1335776077] transaction","detail":"{read_only:false; response_revision:8710; number_of_response:1; }","duration":"105.153781ms","start":"2026-10-26T19:39:13.697345Z","end":"2026-10-26T19:39:13.802499Z","steps":["trace[1335776077] 'process raft request' (duration: 104.956007ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:39:14.270678Z","caller":"traceutil/trace.go:171","msg":"trace[285165212] linearizableReadLoop","detail":"{readStateIndex:9030; appliedIndex:9029; }","duration":"128.310246ms","start":"2026-10-26T19:39:14.142344Z","end":"2026-10-26T19:39:14.270654Z","steps":["trace[285165212] 'read index received' (duration: 80.163233ms)","trace[285165212] 'applied index is now lower than readState.Index' (duration: 48.145823ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:39:14.270975Z","caller":"traceutil/trace.go:171","msg":"trace[694343582] transaction","detail":"{read_only:false; response_revision:8715; number_of_response:1; }","duration":"140.512214ms","start":"2026-10-26T19:39:14.13045Z","end":"2026-10-26T19:39:14.270962Z","steps":["trace[694343582] 'process raft request' (duration: 92.021422ms)","trace[694343582] 'compare' (duration: 48.067501ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:39:14.271216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.801551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xmbnc\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-26T19:39:14.27129Z","caller":"traceutil/trace.go:171","msg":"trace[1381712954] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xmbnc; range_end:; response_count:1; response_revision:8715; }","duration":"115.893713ms","start":"2026-10-26T19:39:14.155379Z","end":"2026-10-26T19:39:14.271272Z","steps":["trace[1381712954] 'agreement among raft nodes before linearized reading' (duration: 115.638657ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:39:14.271409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.039394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-26T19:39:14.271459Z","caller":"traceutil/trace.go:171","msg":"trace[1380929119] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:8715; }","duration":"129.115555ms","start":"2026-10-26T19:39:14.14233Z","end":"2026-10-26T19:39:14.271446Z","steps":["trace[1380929119] 'agreement among raft nodes before linearized reading' (duration: 129.015133ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:39:42.956386Z","caller":"traceutil/trace.go:171","msg":"trace[1301458070] transaction","detail":"{read_only:false; response_revision:8921; number_of_response:1; }","duration":"155.028569ms","start":"2026-10-26T19:39:42.801314Z","end":"2026-10-26T19:39:42.956343Z","steps":["trace[1301458070] 'process raft request' (duration: 154.817944ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:39:42.957264Z","caller":"traceutil/trace.go:171","msg":"trace[142548194] linearizableReadLoop","detail":"{readStateIndex:9243; appliedIndex:9243; }","duration":"139.00801ms","start":"2026-10-26T19:39:42.818235Z","end":"2026-10-26T19:39:42.957243Z","steps":["trace[142548194] 'read index received' (duration: 139.00105ms)","trace[142548194] 'applied index is now lower than readState.Index' (duration: 5.85µs)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:39:42.9575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.241376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-26T19:39:42.957563Z","caller":"traceutil/trace.go:171","msg":"trace[46031902] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8921; }","duration":"139.385239ms","start":"2026-10-26T19:39:42.818159Z","end":"2026-10-26T19:39:42.957545Z","steps":["trace[46031902] 'agreement among raft nodes before linearized reading' (duration: 139.151943ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:39:53.267705Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002457.wal"} {"level":"info","ts":"2026-10-26T19:39:56.325715Z","caller":"traceutil/trace.go:171","msg":"trace[1261955703] transaction","detail":"{read_only:false; response_revision:9000; number_of_response:1; }","duration":"166.773495ms","start":"2026-10-26T19:39:56.158893Z","end":"2026-10-26T19:39:56.325667Z","steps":["trace[1261955703] 'process raft request' (duration: 118.565863ms)","trace[1261955703] 'compare' (duration: 47.902105ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:39:56.576737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.878522ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-26T19:39:56.576893Z","caller":"traceutil/trace.go:171","msg":"trace[527231386] linearizableReadLoop","detail":"{readStateIndex:9330; appliedIndex:9329; }","duration":"139.406459ms","start":"2026-10-26T19:39:56.437463Z","end":"2026-10-26T19:39:56.57687Z","steps":["trace[527231386] 'read index received' (duration: 15.22584ms)","trace[527231386] 'applied index is now lower than readState.Index' (duration: 124.177999ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:39:56.57703Z","caller":"traceutil/trace.go:171","msg":"trace[1813875389] transaction","detail":"{read_only:false; response_revision:9004; number_of_response:1; }","duration":"158.634587ms","start":"2026-10-26T19:39:56.418377Z","end":"2026-10-26T19:39:56.577012Z","steps":["trace[1813875389] 'process raft request' (duration: 34.359015ms)","trace[1813875389] 'compare' (duration: 123.655837ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:39:56.577523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.127407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-26T19:39:56.577585Z","caller":"traceutil/trace.go:171","msg":"trace[1891047697] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9004; }","duration":"140.23714ms","start":"2026-10-26T19:39:56.43733Z","end":"2026-10-26T19:39:56.577568Z","steps":["trace[1891047697] 'agreement among raft nodes before linearized reading' (duration: 140.029725ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:39:56.577857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.705939ms","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-26T19:39:56.577911Z","caller":"traceutil/trace.go:171","msg":"trace[427682746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9004; }","duration":"100.783601ms","start":"2026-10-26T19:39:56.477114Z","end":"2026-10-26T19:39:56.577898Z","steps":["trace[427682746] 'agreement among raft nodes before linearized reading' (duration: 100.656338ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:39:56.718295Z","caller":"traceutil/trace.go:171","msg":"trace[1054302979] transaction","detail":"{read_only:false; response_revision:9006; number_of_response:1; }","duration":"123.80155ms","start":"2026-10-26T19:39:56.59446Z","end":"2026-10-26T19:39:56.718261Z","steps":["trace[1054302979] 'process raft request' (duration: 102.343638ms)","trace[1054302979] 'compare' (duration: 21.298818ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:40:58.993122Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"83287f3a81241ad4","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-26T19:40:58.998174Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-26T19:40:58.998251Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-26T19:41:20.294115Z","caller":"traceutil/trace.go:171","msg":"trace[339699846] transaction","detail":"{read_only:false; response_revision:9820; number_of_response:1; }","duration":"118.221035ms","start":"2026-10-26T19:41:20.175833Z","end":"2026-10-26T19:41:20.294054Z","steps":["trace[339699846] 'process raft request' (duration: 118.00694ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:42:49.935279Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8039} {"level":"info","ts":"2026-10-26T19:42:50.017419Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8039,"took":"80.135001ms","hash":905761533,"current-db-size-bytes":56176640,"current-db-size":"56 MB","current-db-size-in-use-bytes":25235456,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-10-26T19:42:50.017501Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":905761533,"revision":8039,"compact-revision":5778} {"level":"warn","ts":"2026-10-26T19:44:44.85642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.352291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T19:44:44.856528Z","caller":"traceutil/trace.go:171","msg":"trace[63477525] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11569; }","duration":"102.524865ms","start":"2026-10-26T19:44:44.753979Z","end":"2026-10-26T19:44:44.856504Z","steps":["trace[63477525] 'range keys from in-memory index tree' (duration: 102.250319ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:44:44.856892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.846203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-10-26T19:44:44.856903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.800292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xmbnc\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-10-26T19:44:44.85698Z","caller":"traceutil/trace.go:171","msg":"trace[980058590] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xmbnc; range_end:; response_count:1; response_revision:11569; }","duration":"102.908064ms","start":"2026-10-26T19:44:44.754051Z","end":"2026-10-26T19:44:44.856959Z","steps":["trace[980058590] 'range keys from in-memory index tree' (duration: 102.435993ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:44:44.856991Z","caller":"traceutil/trace.go:171","msg":"trace[902545648] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:11569; }","duration":"155.983426ms","start":"2026-10-26T19:44:44.700961Z","end":"2026-10-26T19:44:44.856944Z","steps":["trace[902545648] 'range keys from in-memory index tree' (duration: 155.513965ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:47:49.941957Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10452} {"level":"info","ts":"2026-10-26T19:47:50.027454Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10452,"took":"83.089325ms","hash":340584357,"current-db-size-bytes":56176640,"current-db-size":"56 MB","current-db-size-in-use-bytes":27906048,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-26T19:47:50.027538Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":340584357,"revision":10452,"compact-revision":8039} {"level":"warn","ts":"2026-10-26T19:50:58.05041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.33307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-26T19:50:58.050576Z","caller":"traceutil/trace.go:171","msg":"trace[606963951] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:14086; }","duration":"113.509825ms","start":"2026-10-26T19:50:57.937048Z","end":"2026-10-26T19:50:58.050558Z","steps":["trace[606963951] 'count revisions from in-memory index tree' (duration: 113.148336ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:51:39.030409Z","caller":"traceutil/trace.go:171","msg":"trace[937323402] transaction","detail":"{read_only:false; response_revision:14320; number_of_response:1; }","duration":"258.189238ms","start":"2026-10-26T19:51:38.772195Z","end":"2026-10-26T19:51:39.030384Z","steps":["trace[937323402] 'process raft request' (duration: 258.031234ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:51:39.172485Z","caller":"traceutil/trace.go:171","msg":"trace[1045667332] transaction","detail":"{read_only:false; response_revision:14321; number_of_response:1; }","duration":"352.73999ms","start":"2026-10-26T19:51:38.819719Z","end":"2026-10-26T19:51:39.172459Z","steps":["trace[1045667332] 'process raft request' (duration: 352.530585ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:51:39.172644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:51:38.819698Z","time spent":"352.864072ms","remote":"127.0.0.1:60142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T19:51:39.172666Z","caller":"traceutil/trace.go:171","msg":"trace[2028902095] linearizableReadLoop","detail":"{readStateIndex:14820; appliedIndex:14818; }","duration":"132.734131ms","start":"2026-10-26T19:51:39.039912Z","end":"2026-10-26T19:51:39.172646Z","steps":["trace[2028902095] 'read index received' (duration: 132.28201ms)","trace[2028902095] 'applied index is now lower than readState.Index' (duration: 450.581µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:51:39.172716Z","caller":"traceutil/trace.go:171","msg":"trace[2094720356] transaction","detail":"{read_only:false; response_revision:14322; number_of_response:1; }","duration":"327.933905ms","start":"2026-10-26T19:51:38.844729Z","end":"2026-10-26T19:51:39.172662Z","steps":["trace[2094720356] 'process raft request' (duration: 327.688569ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:51:39.172851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.946667ms","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-10-26T19:51:39.172895Z","caller":"traceutil/trace.go:171","msg":"trace[2019501806] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:14322; }","duration":"133.038299ms","start":"2026-10-26T19:51:39.039845Z","end":"2026-10-26T19:51:39.172883Z","steps":["trace[2019501806] 'agreement among raft nodes before linearized reading' (duration: 132.894496ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:51:39.172895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:51:38.844695Z","time spent":"328.106919ms","remote":"127.0.0.1:60142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T19:51:39.172842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.012114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-10-26T19:51:39.173159Z","caller":"traceutil/trace.go:171","msg":"trace[1054214179] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14322; }","duration":"132.283361ms","start":"2026-10-26T19:51:39.040784Z","end":"2026-10-26T19:51:39.173067Z","steps":["trace[1054214179] 'agreement among raft nodes before linearized reading' (duration: 131.988733ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:51:50.057856Z","caller":"traceutil/trace.go:171","msg":"trace[1792227939] linearizableReadLoop","detail":"{readStateIndex:14994; appliedIndex:14993; }","duration":"114.687503ms","start":"2026-10-26T19:51:49.943141Z","end":"2026-10-26T19:51:50.057829Z","steps":["trace[1792227939] 'read index received' (duration: 114.473347ms)","trace[1792227939] 'applied index is now lower than readState.Index' (duration: 212.835µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:51:50.057936Z","caller":"traceutil/trace.go:171","msg":"trace[1015112132] transaction","detail":"{read_only:false; response_revision:14493; number_of_response:1; }","duration":"115.368199ms","start":"2026-10-26T19:51:49.942527Z","end":"2026-10-26T19:51:50.057895Z","steps":["trace[1015112132] 'process raft request' (duration: 115.123033ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:51:50.058214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.058752ms","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-26T19:51:50.058319Z","caller":"traceutil/trace.go:171","msg":"trace[1826498174] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14493; }","duration":"115.251047ms","start":"2026-10-26T19:51:49.943047Z","end":"2026-10-26T19:51:50.058298Z","steps":["trace[1826498174] 'agreement among raft nodes before linearized reading' (duration: 114.920949ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:51:50.342424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.442281ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T19:51:50.342616Z","caller":"traceutil/trace.go:171","msg":"trace[207720511] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:14494; }","duration":"108.683606ms","start":"2026-10-26T19:51:50.2339Z","end":"2026-10-26T19:51:50.342584Z","steps":["trace[207720511] 'range keys from in-memory index tree' (duration: 108.41143ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:51:50.342612Z","caller":"traceutil/trace.go:171","msg":"trace[1018103643] transaction","detail":"{read_only:false; response_revision:14495; number_of_response:1; }","duration":"133.272745ms","start":"2026-10-26T19:51:50.209299Z","end":"2026-10-26T19:51:50.342572Z","steps":["trace[1018103643] 'process raft request' (duration: 105.769915ms)","trace[1018103643] 'compare' (duration: 27.334166ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:51:50.342848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.223172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-26T19:51:50.342937Z","caller":"traceutil/trace.go:171","msg":"trace[52178862] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:14494; }","duration":"183.686394ms","start":"2026-10-26T19:51:50.159231Z","end":"2026-10-26T19:51:50.342917Z","steps":["trace[52178862] 'range keys from in-memory index tree' (duration: 183.076178ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:52:49.952776Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12770} {"level":"info","ts":"2026-10-26T19:52:50.036913Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12770,"took":"80.912561ms","hash":924923591,"current-db-size-bytes":56176640,"current-db-size":"56 MB","current-db-size-in-use-bytes":31113216,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-26T19:52:50.037022Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":924923591,"revision":12770,"compact-revision":10452} {"level":"warn","ts":"2026-10-26T19:53:33.537036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.651191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.167\" ","response":"range_response_count:1 size:138"} {"level":"info","ts":"2026-10-26T19:53:33.537201Z","caller":"traceutil/trace.go:171","msg":"trace[384247355] range","detail":"{range_begin:/registry/masterleases/162.253.55.167; range_end:; response_count:1; response_revision:15599; }","duration":"240.888386ms","start":"2026-10-26T19:53:33.296285Z","end":"2026-10-26T19:53:33.537173Z","steps":["trace[384247355] 'range keys from in-memory index tree' (duration: 240.428255ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:57:49.961028Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15343} {"level":"info","ts":"2026-10-26T19:57:50.068532Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15343,"took":"102.183916ms","hash":2442964294,"current-db-size-bytes":56176640,"current-db-size":"56 MB","current-db-size-in-use-bytes":31903744,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-26T19:57:50.068615Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2442964294,"revision":15343,"compact-revision":12770} {"level":"info","ts":"2026-10-26T19:59:06.084953Z","caller":"traceutil/trace.go:171","msg":"trace[1396643316] transaction","detail":"{read_only:false; response_revision:18118; number_of_response:1; }","duration":"138.819679ms","start":"2026-10-26T19:59:05.94611Z","end":"2026-10-26T19:59:06.08493Z","steps":["trace[1396643316] 'process raft request' (duration: 138.586613ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:59:14.075789Z","caller":"traceutil/trace.go:171","msg":"trace[351333281] linearizableReadLoop","detail":"{readStateIndex:18809; appliedIndex:18808; }","duration":"121.042306ms","start":"2026-10-26T19:59:13.954725Z","end":"2026-10-26T19:59:14.075767Z","steps":["trace[351333281] 'read index received' (duration: 120.81457ms)","trace[351333281] 'applied index is now lower than readState.Index' (duration: 226.716µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:59:14.075863Z","caller":"traceutil/trace.go:171","msg":"trace[1937755548] transaction","detail":"{read_only:false; response_revision:18188; number_of_response:1; }","duration":"147.403767ms","start":"2026-10-26T19:59:13.928424Z","end":"2026-10-26T19:59:14.075827Z","steps":["trace[1937755548] 'process raft request' (duration: 147.197702ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:59:14.076048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.291713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-10-26T19:59:14.076151Z","caller":"traceutil/trace.go:171","msg":"trace[1922969948] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:18188; }","duration":"121.449456ms","start":"2026-10-26T19:59:13.954684Z","end":"2026-10-26T19:59:14.076133Z","steps":["trace[1922969948] 'agreement among raft nodes before linearized reading' (duration: 121.18938ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T19:59:14.654851Z","caller":"traceutil/trace.go:171","msg":"trace[1105543246] transaction","detail":"{read_only:false; response_revision:18189; number_of_response:1; }","duration":"495.889301ms","start":"2026-10-26T19:59:14.158937Z","end":"2026-10-26T19:59:14.654827Z","steps":["trace[1105543246] 'process raft request' (duration: 495.715047ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:59:14.655157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:59:14.158901Z","time spent":"496.146257ms","remote":"127.0.0.1:60076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":21017,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T19:59:14.720661Z","caller":"traceutil/trace.go:171","msg":"trace[480431146] linearizableReadLoop","detail":"{readStateIndex:18811; appliedIndex:18809; }","duration":"271.195241ms","start":"2026-10-26T19:59:14.449445Z","end":"2026-10-26T19:59:14.72064Z","steps":["trace[480431146] 'read index received' (duration: 205.211695ms)","trace[480431146] 'applied index is now lower than readState.Index' (duration: 65.982656ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T19:59:14.721138Z","caller":"traceutil/trace.go:171","msg":"trace[627618086] transaction","detail":"{read_only:false; response_revision:18190; number_of_response:1; }","duration":"544.248498ms","start":"2026-10-26T19:59:14.176863Z","end":"2026-10-26T19:59:14.721111Z","steps":["trace[627618086] 'process raft request' (duration: 510.279491ms)","trace[627618086] 'compare' (duration: 33.397713ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T19:59:14.721863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T19:59:14.176835Z","time spent":"544.951885ms","remote":"127.0.0.1:60142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T19:59:14.721333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.868878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-26T19:59:14.722114Z","caller":"traceutil/trace.go:171","msg":"trace[655293062] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18190; }","duration":"272.659157ms","start":"2026-10-26T19:59:14.449395Z","end":"2026-10-26T19:59:14.722055Z","steps":["trace[655293062] 'agreement among raft nodes before linearized reading' (duration: 271.748455ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:59:14.721578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.580224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T19:59:14.722281Z","caller":"traceutil/trace.go:171","msg":"trace[1891344332] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18190; }","duration":"183.278001ms","start":"2026-10-26T19:59:14.538986Z","end":"2026-10-26T19:59:14.722264Z","steps":["trace[1891344332] 'agreement among raft nodes before linearized reading' (duration: 182.553933ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:59:14.721697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.980316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-zgzvv\" ","response":"range_response_count:1 size:9797"} {"level":"info","ts":"2026-10-26T19:59:14.722454Z","caller":"traceutil/trace.go:171","msg":"trace[519592853] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-zgzvv; range_end:; response_count:1; response_revision:18190; }","duration":"135.754115ms","start":"2026-10-26T19:59:14.58668Z","end":"2026-10-26T19:59:14.722434Z","steps":["trace[519592853] 'agreement among raft nodes before linearized reading' (duration: 134.910004ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T19:59:14.721708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.523028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" ","response":"range_response_count:1 size:3298"} {"level":"info","ts":"2026-10-26T19:59:14.722681Z","caller":"traceutil/trace.go:171","msg":"trace[167797965] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat; range_end:; response_count:1; response_revision:18190; }","duration":"175.492082ms","start":"2026-10-26T19:59:14.547155Z","end":"2026-10-26T19:59:14.722647Z","steps":["trace[167797965] 'agreement among raft nodes before linearized reading' (duration: 174.448497ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:01:20.452531Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"83287f3a81241ad4","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-26T20:01:20.458805Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-26T20:01:20.458972Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-26T20:02:49.967192Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17517} {"level":"info","ts":"2026-10-26T20:02:50.06796Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17517,"took":"97.311719ms","hash":4232121779,"current-db-size-bytes":56176640,"current-db-size":"56 MB","current-db-size-in-use-bytes":35545088,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-26T20:02:50.068032Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4232121779,"revision":17517,"compact-revision":15343} {"level":"info","ts":"2026-10-26T20:04:31.634848Z","caller":"traceutil/trace.go:171","msg":"trace[1388691525] transaction","detail":"{read_only:false; response_revision:20698; number_of_response:1; }","duration":"120.062892ms","start":"2026-10-26T20:04:31.514757Z","end":"2026-10-26T20:04:31.63482Z","steps":["trace[1388691525] 'process raft request' (duration: 119.858277ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:04:32.200596Z","caller":"traceutil/trace.go:171","msg":"trace[449689539] linearizableReadLoop","detail":"{readStateIndex:21401; appliedIndex:21400; }","duration":"140.719425ms","start":"2026-10-26T20:04:32.059843Z","end":"2026-10-26T20:04:32.200563Z","steps":["trace[449689539] 'read index received' (duration: 140.539561ms)","trace[449689539] 'applied index is now lower than readState.Index' (duration: 178.734µs)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:04:32.200665Z","caller":"traceutil/trace.go:171","msg":"trace[1544098627] transaction","detail":"{read_only:false; response_revision:20699; number_of_response:1; }","duration":"188.017517ms","start":"2026-10-26T20:04:32.012606Z","end":"2026-10-26T20:04:32.200623Z","steps":["trace[1544098627] 'process raft request' (duration: 187.797411ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:04:32.201037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.180956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:26 size:234993"} {"level":"info","ts":"2026-10-26T20:04:32.201106Z","caller":"traceutil/trace.go:171","msg":"trace[420607266] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:26; response_revision:20699; }","duration":"141.276249ms","start":"2026-10-26T20:04:32.059793Z","end":"2026-10-26T20:04:32.20107Z","steps":["trace[420607266] 'agreement among raft nodes before linearized reading' (duration: 140.875139ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:04:32.670099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.010165ms","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-26T20:04:32.67021Z","caller":"traceutil/trace.go:171","msg":"trace[421755760] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20701; }","duration":"167.19394ms","start":"2026-10-26T20:04:32.502988Z","end":"2026-10-26T20:04:32.670182Z","steps":["trace[421755760] 'range keys from in-memory index tree' (duration: 166.788079ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:04:32.670096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.257687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-26T20:04:32.670397Z","caller":"traceutil/trace.go:171","msg":"trace[322707748] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20701; }","duration":"196.627926ms","start":"2026-10-26T20:04:32.473741Z","end":"2026-10-26T20:04:32.670369Z","steps":["trace[322707748] 'range keys from in-memory index tree' (duration: 196.118433ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:04:32.872156Z","caller":"traceutil/trace.go:171","msg":"trace[2064207649] linearizableReadLoop","detail":"{readStateIndex:21407; appliedIndex:21403; }","duration":"188.379575ms","start":"2026-10-26T20:04:32.683752Z","end":"2026-10-26T20:04:32.872132Z","steps":["trace[2064207649] 'read index received' (duration: 65.483224ms)","trace[2064207649] 'applied index is now lower than readState.Index' (duration: 122.895301ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:04:32.872201Z","caller":"traceutil/trace.go:171","msg":"trace[1944092121] transaction","detail":"{read_only:false; response_revision:20704; number_of_response:1; }","duration":"197.480327ms","start":"2026-10-26T20:04:32.674681Z","end":"2026-10-26T20:04:32.872162Z","steps":["trace[1944092121] 'process raft request' (duration: 197.18957ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:04:32.872294Z","caller":"traceutil/trace.go:171","msg":"trace[1584836017] transaction","detail":"{read_only:false; response_revision:20705; number_of_response:1; }","duration":"195.636722ms","start":"2026-10-26T20:04:32.676644Z","end":"2026-10-26T20:04:32.872281Z","steps":["trace[1584836017] 'process raft request' (duration: 195.423177ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:04:32.872413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.449613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T20:04:32.872463Z","caller":"traceutil/trace.go:171","msg":"trace[2088401510] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20705; }","duration":"118.544406ms","start":"2026-10-26T20:04:32.753907Z","end":"2026-10-26T20:04:32.872452Z","steps":["trace[2088401510] 'agreement among raft nodes before linearized reading' (duration: 118.426993ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:04:32.87246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.683312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T20:04:32.872527Z","caller":"traceutil/trace.go:171","msg":"trace[1632313382] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:20705; }","duration":"188.803566ms","start":"2026-10-26T20:04:32.683708Z","end":"2026-10-26T20:04:32.872511Z","steps":["trace[1632313382] 'agreement among raft nodes before linearized reading' (duration: 188.664982ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:07:49.976219Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20050} {"level":"info","ts":"2026-10-26T20:07:50.0943Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20050,"took":"114.450879ms","hash":3576765093,"current-db-size-bytes":56176640,"current-db-size":"56 MB","current-db-size-in-use-bytes":31444992,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-26T20:07:50.094368Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3576765093,"revision":20050,"compact-revision":17517} {"level":"info","ts":"2026-10-26T20:11:58.306476Z","caller":"traceutil/trace.go:171","msg":"trace[1134330820] transaction","detail":"{read_only:false; response_revision:25291; number_of_response:1; }","duration":"149.850722ms","start":"2026-10-26T20:11:58.156599Z","end":"2026-10-26T20:11:58.30645Z","steps":["trace[1134330820] 'process raft request' (duration: 134.906018ms)","trace[1134330820] 'compare' (duration: 14.534224ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:11:58.306946Z","caller":"traceutil/trace.go:171","msg":"trace[1483798856] transaction","detail":"{read_only:false; response_revision:25293; number_of_response:1; }","duration":"101.594016ms","start":"2026-10-26T20:11:58.205325Z","end":"2026-10-26T20:11:58.306919Z","steps":["trace[1483798856] 'process raft request' (duration: 101.519654ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:11:58.306989Z","caller":"traceutil/trace.go:171","msg":"trace[2048742781] transaction","detail":"{read_only:false; response_revision:25292; number_of_response:1; }","duration":"117.711359ms","start":"2026-10-26T20:11:58.189262Z","end":"2026-10-26T20:11:58.306974Z","steps":["trace[2048742781] 'process raft request' (duration: 117.113204ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:11:58.610173Z","caller":"traceutil/trace.go:171","msg":"trace[448536883] transaction","detail":"{read_only:false; response_revision:25294; number_of_response:1; }","duration":"311.986573ms","start":"2026-10-26T20:11:58.298151Z","end":"2026-10-26T20:11:58.610138Z","steps":["trace[448536883] 'process raft request' (duration: 270.133983ms)","trace[448536883] 'compare' (duration: 41.650645ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:11:58.610438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:11:58.298126Z","time spent":"312.214439ms","remote":"127.0.0.1:60142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-26T20:11:58.693465Z","caller":"traceutil/trace.go:171","msg":"trace[195012290] transaction","detail":"{read_only:false; response_revision:25295; number_of_response:1; }","duration":"332.399481ms","start":"2026-10-26T20:11:58.360997Z","end":"2026-10-26T20:11:58.693397Z","steps":["trace[195012290] 'process raft request' (duration: 332.099244ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:11:58.693643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:11:58.36097Z","time spent":"332.579155ms","remote":"127.0.0.1:60142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T20:11:58.855831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.521641ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-26T20:11:58.856307Z","caller":"traceutil/trace.go:171","msg":"trace[1583282280] linearizableReadLoop","detail":"{readStateIndex:26121; appliedIndex:26118; }","duration":"241.289251ms","start":"2026-10-26T20:11:58.614983Z","end":"2026-10-26T20:11:58.856273Z","steps":["trace[1583282280] 'read index received' (duration: 78.024132ms)","trace[1583282280] 'applied index is now lower than readState.Index' (duration: 163.261849ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:11:58.856353Z","caller":"traceutil/trace.go:171","msg":"trace[1329733731] transaction","detail":"{read_only:false; response_revision:25296; number_of_response:1; }","duration":"383.25686ms","start":"2026-10-26T20:11:58.473069Z","end":"2026-10-26T20:11:58.856325Z","steps":["trace[1329733731] 'process raft request' (duration: 382.86747ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:11:58.856507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-26T20:11:58.473044Z","time spent":"383.365913ms","remote":"127.0.0.1:60142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-26T20:11:58.863978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.962808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12433"} {"level":"warn","ts":"2026-10-26T20:11:58.864024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.034623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T20:11:58.864071Z","caller":"traceutil/trace.go:171","msg":"trace[1797931163] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25296; }","duration":"249.111811ms","start":"2026-10-26T20:11:58.614934Z","end":"2026-10-26T20:11:58.864046Z","steps":["trace[1797931163] 'agreement among raft nodes before linearized reading' (duration: 241.435134ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:11:58.864125Z","caller":"traceutil/trace.go:171","msg":"trace[1157006110] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25297; }","duration":"108.177147ms","start":"2026-10-26T20:11:58.755929Z","end":"2026-10-26T20:11:58.864106Z","steps":["trace[1157006110] 'agreement among raft nodes before linearized reading' (duration: 108.025283ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:12:49.98465Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22360} {"level":"info","ts":"2026-10-26T20:12:50.110365Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22360,"took":"121.530842ms","hash":3779995332,"current-db-size-bytes":56176640,"current-db-size":"56 MB","current-db-size-in-use-bytes":45789184,"current-db-size-in-use":"46 MB"} {"level":"info","ts":"2026-10-26T20:12:50.110436Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3779995332,"revision":22360,"compact-revision":20050} {"level":"info","ts":"2026-10-26T20:12:58.743393Z","caller":"traceutil/trace.go:171","msg":"trace[235096611] transaction","detail":"{read_only:false; response_revision:25836; number_of_response:1; }","duration":"135.452541ms","start":"2026-10-26T20:12:58.607909Z","end":"2026-10-26T20:12:58.743362Z","steps":["trace[235096611] 'process raft request' (duration: 135.288207ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:12:59.034817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.260178ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-26T20:12:59.035048Z","caller":"traceutil/trace.go:171","msg":"trace[1514318931] transaction","detail":"{read_only:false; response_revision:25837; number_of_response:1; }","duration":"254.758739ms","start":"2026-10-26T20:12:58.780269Z","end":"2026-10-26T20:12:59.035028Z","steps":["trace[1514318931] 'process raft request' (duration: 106.997478ms)","trace[1514318931] 'compare' (duration: 147.070614ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:12:59.076514Z","caller":"traceutil/trace.go:171","msg":"trace[1392576249] transaction","detail":"{read_only:false; response_revision:25838; number_of_response:1; }","duration":"239.285032ms","start":"2026-10-26T20:12:58.837188Z","end":"2026-10-26T20:12:59.076473Z","steps":["trace[1392576249] 'process raft request' (duration: 239.067487ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:12:59.076542Z","caller":"traceutil/trace.go:171","msg":"trace[342375833] transaction","detail":"{read_only:false; response_revision:25839; number_of_response:1; }","duration":"211.128446ms","start":"2026-10-26T20:12:58.86538Z","end":"2026-10-26T20:12:59.076509Z","steps":["trace[342375833] 'process raft request' (duration: 211.021583ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:12:59.336582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.123602ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-26T20:12:59.336848Z","caller":"traceutil/trace.go:171","msg":"trace[349328861] transaction","detail":"{read_only:false; response_revision:25841; number_of_response:1; }","duration":"231.999464ms","start":"2026-10-26T20:12:59.104703Z","end":"2026-10-26T20:12:59.336703Z","steps":["trace[349328861] 'process raft request' (duration: 231.951803ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:12:59.336826Z","caller":"traceutil/trace.go:171","msg":"trace[57738966] transaction","detail":"{read_only:false; response_revision:25840; number_of_response:1; }","duration":"232.725592ms","start":"2026-10-26T20:12:59.104048Z","end":"2026-10-26T20:12:59.336774Z","steps":["trace[57738966] 'process raft request' (duration: 95.231621ms)","trace[57738966] 'compare' (duration: 136.879646ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:12:59.660804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.856133ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-26T20:12:59.660867Z","caller":"traceutil/trace.go:171","msg":"trace[1166124730] linearizableReadLoop","detail":"{readStateIndex:26681; appliedIndex:26680; }","duration":"217.672945ms","start":"2026-10-26T20:12:59.443183Z","end":"2026-10-26T20:12:59.660856Z","steps":["trace[1166124730] 'read index received' (duration: 76.653528ms)","trace[1166124730] 'applied index is now lower than readState.Index' (duration: 141.018677ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:12:59.660906Z","caller":"traceutil/trace.go:171","msg":"trace[1566482101] transaction","detail":"{read_only:false; response_revision:25842; number_of_response:1; }","duration":"221.397366ms","start":"2026-10-26T20:12:59.439502Z","end":"2026-10-26T20:12:59.6609Z","steps":["trace[1566482101] 'process raft request' (duration: 80.3927ms)","trace[1566482101] 'compare' (duration: 140.78143ms)"],"step_count":2} {"level":"warn","ts":"2026-10-26T20:12:59.661132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.917762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-10-26T20:12:59.661236Z","caller":"traceutil/trace.go:171","msg":"trace[1784647589] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25842; }","duration":"216.021174ms","start":"2026-10-26T20:12:59.44517Z","end":"2026-10-26T20:12:59.661191Z","steps":["trace[1784647589] 'agreement among raft nodes before linearized reading' (duration: 215.813829ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:12:59.661249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.076974ms","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-26T20:12:59.661267Z","caller":"traceutil/trace.go:171","msg":"trace[1437683498] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25842; }","duration":"218.137136ms","start":"2026-10-26T20:12:59.443125Z","end":"2026-10-26T20:12:59.661262Z","steps":["trace[1437683498] 'agreement among raft nodes before linearized reading' (duration: 218.070104ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:12:59.661493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.026004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-26T20:12:59.661596Z","caller":"traceutil/trace.go:171","msg":"trace[755656146] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25842; }","duration":"186.179207ms","start":"2026-10-26T20:12:59.475396Z","end":"2026-10-26T20:12:59.661575Z","steps":["trace[755656146] 'agreement among raft nodes before linearized reading' (duration: 185.942401ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:12:59.861111Z","caller":"traceutil/trace.go:171","msg":"trace[617164780] transaction","detail":"{read_only:false; response_revision:25843; number_of_response:1; }","duration":"195.608877ms","start":"2026-10-26T20:12:59.665462Z","end":"2026-10-26T20:12:59.861071Z","steps":["trace[617164780] 'process raft request' (duration: 195.389702ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:12:59.862542Z","caller":"traceutil/trace.go:171","msg":"trace[1059418630] transaction","detail":"{read_only:false; response_revision:25844; number_of_response:1; }","duration":"196.95834ms","start":"2026-10-26T20:12:59.665552Z","end":"2026-10-26T20:12:59.86251Z","steps":["trace[1059418630] 'process raft request' (duration: 196.771986ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:12:59.86264Z","caller":"traceutil/trace.go:171","msg":"trace[1489266205] linearizableReadLoop","detail":"{readStateIndex:26685; appliedIndex:26681; }","duration":"108.374891ms","start":"2026-10-26T20:12:59.754217Z","end":"2026-10-26T20:12:59.862591Z","steps":["trace[1489266205] 'read index received' (duration: 106.647569ms)","trace[1489266205] 'applied index is now lower than readState.Index' (duration: 1.726042ms)"],"step_count":2} {"level":"info","ts":"2026-10-26T20:12:59.862666Z","caller":"traceutil/trace.go:171","msg":"trace[633242589] transaction","detail":"{read_only:false; response_revision:25845; number_of_response:1; }","duration":"196.94935ms","start":"2026-10-26T20:12:59.66568Z","end":"2026-10-26T20:12:59.862629Z","steps":["trace[633242589] 'process raft request' (duration: 196.724875ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:12:59.862716Z","caller":"traceutil/trace.go:171","msg":"trace[1438417142] transaction","detail":"{read_only:false; response_revision:25846; number_of_response:1; }","duration":"196.860288ms","start":"2026-10-26T20:12:59.665844Z","end":"2026-10-26T20:12:59.862704Z","steps":["trace[1438417142] 'process raft request' (duration: 196.611642ms)"],"step_count":1} {"level":"warn","ts":"2026-10-26T20:12:59.862834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.596507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-26T20:12:59.862887Z","caller":"traceutil/trace.go:171","msg":"trace[294615621] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25846; }","duration":"108.682948ms","start":"2026-10-26T20:12:59.754188Z","end":"2026-10-26T20:12:59.862871Z","steps":["trace[294615621] 'agreement among raft nodes before linearized reading' (duration: 108.565055ms)"],"step_count":1} {"level":"info","ts":"2026-10-26T20:13:27.514617Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006922.wal"} {"level":"info","ts":"2026-10-26T20:17:49.993932Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25773} {"level":"info","ts":"2026-10-26T20:17:50.161766Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25773,"took":"163.48541ms","hash":1010230173,"current-db-size-bytes":57864192,"current-db-size":"58 MB","current-db-size-in-use-bytes":36110336,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-26T20:17:50.161842Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1010230173,"revision":25773,"compact-revision":22360} {"level":"info","ts":"2026-10-26T20:18:49.795276Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"83287f3a81241ad4","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-26T20:18:49.802641Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-26T20:18:49.802741Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-26T20:22:50.000952Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28643} {"level":"info","ts":"2026-10-26T20:22:50.150019Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28643,"took":"144.832497ms","hash":3784028298,"current-db-size-bytes":57864192,"current-db-size":"58 MB","current-db-size-in-use-bytes":31002624,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-26T20:22:50.150093Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3784028298,"revision":28643,"compact-revision":25773} {"level":"info","ts":"2026-10-26T20:27:50.008066Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30866} {"level":"info","ts":"2026-10-26T20:27:50.141779Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30866,"took":"129.600577ms","hash":530985827,"current-db-size-bytes":57864192,"current-db-size":"58 MB","current-db-size-in-use-bytes":30527488,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-26T20:27:50.141863Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":530985827,"revision":30866,"compact-revision":28643} {"level":"info","ts":"2026-10-26T20:32:50.014716Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33121} {"level":"info","ts":"2026-10-26T20:32:50.185609Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33121,"took":"165.666296ms","hash":335346294,"current-db-size-bytes":58908672,"current-db-size":"59 MB","current-db-size-in-use-bytes":31178752,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-26T20:32:50.185679Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":335346294,"revision":33121,"compact-revision":30866} {"level":"info","ts":"2026-10-26T20:37:50.024853Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35415} {"level":"info","ts":"2026-10-26T20:37:50.173532Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35415,"took":"144.473699ms","hash":175446185,"current-db-size-bytes":58908672,"current-db-size":"59 MB","current-db-size-in-use-bytes":31895552,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-26T20:37:50.17368Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":175446185,"revision":35415,"compact-revision":33121} {"level":"info","ts":"2026-10-26T20:40:15.702212Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"83287f3a81241ad4","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-26T20:40:15.708078Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-26T20:40:15.708227Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-26T20:42:50.03344Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37645} {"level":"info","ts":"2026-10-26T20:42:50.171366Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37645,"took":"133.54342ms","hash":4245989060,"current-db-size-bytes":60174336,"current-db-size":"60 MB","current-db-size-in-use-bytes":33099776,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-26T20:42:50.171443Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4245989060,"revision":37645,"compact-revision":35415}