{"level":"warn","ts":"2026-07-30T23:46:01.990661Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-30T23:46:01.99074Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-07-30T23:46:01.990799Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-07-30T23:46:01.990807Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]}
{"level":"info","ts":"2026-07-30T23:46:01.990823Z","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-07-30T23:46:01.991404Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]}
{"level":"info","ts":"2026-07-30T23:46:01.991477Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-07-30T23:46:01.994388Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.637586ms"}
{"level":"info","ts":"2026-07-30T23:46:02.000936Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"}
{"level":"info","ts":"2026-07-30T23:46:02.000999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"}
{"level":"info","ts":"2026-07-30T23:46:02.001019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"}
{"level":"info","ts":"2026-07-30T23:46:02.001027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-07-30T23:46:02.001035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"}
{"level":"info","ts":"2026-07-30T23:46:02.001075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"}
{"level":"warn","ts":"2026-07-30T23:46:02.005565Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-07-30T23:46:02.006857Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-07-30T23:46:02.008161Z","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-07-30T23:46:02.010009Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-07-30T23:46:02.010204Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-07-30T23:46:02.010319Z","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-07-30T23:46:02.010416Z","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-07-30T23:46:02.010436Z","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-07-30T23:46:02.011861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"}
{"level":"info","ts":"2026-07-30T23:46:02.012822Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]}
{"level":"info","ts":"2026-07-30T23:46:02.014749Z","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-07-30T23:46:02.01491Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"}
{"level":"info","ts":"2026-07-30T23:46:02.014939Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"}
{"level":"info","ts":"2026-07-30T23:46:02.015013Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-07-30T23:46:02.015066Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-07-30T23:46:02.30177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"}
{"level":"info","ts":"2026-07-30T23:46:02.30185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"}
{"level":"info","ts":"2026-07-30T23:46:02.301892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"}
{"level":"info","ts":"2026-07-30T23:46:02.301913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"}
{"level":"info","ts":"2026-07-30T23:46:02.301925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"}
{"level":"info","ts":"2026-07-30T23:46:02.301941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"}
{"level":"info","ts":"2026-07-30T23:46:02.301956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"}
{"level":"info","ts":"2026-07-30T23:46:02.303067Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"}
{"level":"info","ts":"2026-07-30T23:46:02.30311Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-30T23:46:02.30307Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-30T23:46:02.303225Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-07-30T23:46:02.30347Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-07-30T23:46:02.30367Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-07-30T23:46:02.304144Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-30T23:46:02.304306Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-30T23:46:02.304377Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-07-30T23:46:02.30638Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"}
{"level":"info","ts":"2026-07-30T23:46:02.307328Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-07-30T23:46:44.83884Z","caller":"traceutil/trace.go:171","msg":"trace[634418364] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"144.229159ms","start":"2026-07-30T23:46:44.694583Z","end":"2026-07-30T23:46:44.838812Z","steps":["trace[634418364] 'process raft request'  (duration: 63.174945ms)","trace[634418364] 'compare'  (duration: 80.925261ms)"],"step_count":2}
{"level":"info","ts":"2026-07-30T23:46:45.563016Z","caller":"traceutil/trace.go:171","msg":"trace[1662037346] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"327.231476ms","start":"2026-07-30T23:46:45.23575Z","end":"2026-07-30T23:46:45.562981Z","steps":["trace[1662037346] 'process raft request'  (duration: 323.964167ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T23:46:45.564566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:46:45.235718Z","time spent":"327.37655ms","remote":"127.0.0.1:45330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:628 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036197 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-07-30T23:48:02.940097Z","caller":"traceutil/trace.go:171","msg":"trace[108838166] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"126.203797ms","start":"2026-07-30T23:48:02.813854Z","end":"2026-07-30T23:48:02.940058Z","steps":["trace[108838166] 'process raft request'  (duration: 125.967901ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T23:48:03.156356Z","caller":"traceutil/trace.go:171","msg":"trace[582880219] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"127.831423ms","start":"2026-07-30T23:48:03.028491Z","end":"2026-07-30T23:48:03.156323Z","steps":["trace[582880219] 'process raft request'  (duration: 120.534554ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T23:48:05.458056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.239132ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5646845109337234469 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:1363 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-30T23:48:05.458258Z","caller":"traceutil/trace.go:171","msg":"trace[1117172818] linearizableReadLoop","detail":"{readStateIndex:1408; appliedIndex:1407; }","duration":"253.409045ms","start":"2026-07-30T23:48:05.204825Z","end":"2026-07-30T23:48:05.458234Z","steps":["trace[1117172818] 'read index received'  (duration: 101.679393ms)","trace[1117172818] 'applied index is now lower than readState.Index'  (duration: 151.727252ms)"],"step_count":2}
{"level":"info","ts":"2026-07-30T23:48:05.458357Z","caller":"traceutil/trace.go:171","msg":"trace[2144911681] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"263.101825ms","start":"2026-07-30T23:48:05.195221Z","end":"2026-07-30T23:48:05.458323Z","steps":["trace[2144911681] 'process raft request'  (duration: 111.24652ms)","trace[2144911681] 'compare'  (duration: 150.577458ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-30T23:48:05.458545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.711522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-07-30T23:48:05.458586Z","caller":"traceutil/trace.go:171","msg":"trace[509522702] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1370; }","duration":"253.810784ms","start":"2026-07-30T23:48:05.204765Z","end":"2026-07-30T23:48:05.458576Z","steps":["trace[509522702] 'agreement among raft nodes before linearized reading'  (duration: 253.592879ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T23:48:05.458565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.957304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-07-30T23:48:05.458652Z","caller":"traceutil/trace.go:171","msg":"trace[1313540435] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1370; }","duration":"139.114509ms","start":"2026-07-30T23:48:05.319519Z","end":"2026-07-30T23:48:05.458634Z","steps":["trace[1313540435] 'agreement among raft nodes before linearized reading'  (duration: 138.904023ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T23:48:05.744105Z","caller":"traceutil/trace.go:171","msg":"trace[1132703515] linearizableReadLoop","detail":"{readStateIndex:1410; appliedIndex:1408; }","duration":"211.369707ms","start":"2026-07-30T23:48:05.532712Z","end":"2026-07-30T23:48:05.744081Z","steps":["trace[1132703515] 'read index received'  (duration: 209.209823ms)","trace[1132703515] 'applied index is now lower than readState.Index'  (duration: 2.158494ms)"],"step_count":2}
{"level":"info","ts":"2026-07-30T23:48:05.744156Z","caller":"traceutil/trace.go:171","msg":"trace[1903339995] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"280.118763ms","start":"2026-07-30T23:48:05.464012Z","end":"2026-07-30T23:48:05.744131Z","steps":["trace[1903339995] 'process raft request'  (duration: 279.978591ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T23:48:05.744187Z","caller":"traceutil/trace.go:171","msg":"trace[475765644] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"280.644656ms","start":"2026-07-30T23:48:05.46344Z","end":"2026-07-30T23:48:05.744085Z","steps":["trace[475765644] 'process raft request'  (duration: 278.39049ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T23:48:05.744275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.539452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-07-30T23:48:05.744369Z","caller":"traceutil/trace.go:171","msg":"trace[35901085] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1372; }","duration":"211.683405ms","start":"2026-07-30T23:48:05.532668Z","end":"2026-07-30T23:48:05.744351Z","steps":["trace[35901085] 'agreement among raft nodes before linearized reading'  (duration: 211.543451ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T23:48:20.596398Z","caller":"traceutil/trace.go:171","msg":"trace[229009281] linearizableReadLoop","detail":"{readStateIndex:1587; appliedIndex:1586; }","duration":"225.918675ms","start":"2026-07-30T23:48:20.370456Z","end":"2026-07-30T23:48:20.596375Z","steps":["trace[229009281] 'read index received'  (duration: 225.715261ms)","trace[229009281] 'applied index is now lower than readState.Index'  (duration: 202.754µs)"],"step_count":2}
{"level":"info","ts":"2026-07-30T23:48:20.59656Z","caller":"traceutil/trace.go:171","msg":"trace[2074679500] transaction","detail":"{read_only:false; response_revision:1541; number_of_response:1; }","duration":"313.57488ms","start":"2026-07-30T23:48:20.282938Z","end":"2026-07-30T23:48:20.596513Z","steps":["trace[2074679500] 'process raft request'  (duration: 313.289094ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T23:48:20.596593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.103779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-30T23:48:20.596714Z","caller":"traceutil/trace.go:171","msg":"trace[375522337] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1541; }","duration":"226.263751ms","start":"2026-07-30T23:48:20.37043Z","end":"2026-07-30T23:48:20.596694Z","steps":["trace[375522337] 'agreement among raft nodes before linearized reading'  (duration: 226.096628ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T23:48:20.596809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:48:20.282922Z","time spent":"313.736783ms","remote":"127.0.0.1:45526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" mod_revision:1489 > success:<request_put:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" value_size:432 >> failure:<request_range:<key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-07-30T23:48:20.59682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.463182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-07-30T23:48:20.596904Z","caller":"traceutil/trace.go:171","msg":"trace[1493905505] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1541; }","duration":"177.595274ms","start":"2026-07-30T23:48:20.41929Z","end":"2026-07-30T23:48:20.596885Z","steps":["trace[1493905505] 'agreement among raft nodes before linearized reading'  (duration: 177.344239ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T23:48:20.919643Z","caller":"traceutil/trace.go:171","msg":"trace[1591803742] transaction","detail":"{read_only:false; response_revision:1544; number_of_response:1; }","duration":"192.873622ms","start":"2026-07-30T23:48:20.726691Z","end":"2026-07-30T23:48:20.919565Z","steps":["trace[1591803742] 'process raft request'  (duration: 177.915222ms)","trace[1591803742] 'compare'  (duration: 14.793977ms)"],"step_count":2}
{"level":"info","ts":"2026-07-30T23:48:53.347683Z","caller":"traceutil/trace.go:171","msg":"trace[407282011] linearizableReadLoop","detail":"{readStateIndex:2206; appliedIndex:2205; }","duration":"163.667897ms","start":"2026-07-30T23:48:53.183997Z","end":"2026-07-30T23:48:53.347665Z","steps":["trace[407282011] 'read index received'  (duration: 163.522824ms)","trace[407282011] 'applied index is now lower than readState.Index'  (duration: 143.913µs)"],"step_count":2}
{"level":"info","ts":"2026-07-30T23:48:53.347776Z","caller":"traceutil/trace.go:171","msg":"trace[1697341033] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"277.373271ms","start":"2026-07-30T23:48:53.070373Z","end":"2026-07-30T23:48:53.347746Z","steps":["trace[1697341033] 'process raft request'  (duration: 277.170626ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T23:48:53.347929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.915533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-07-30T23:48:53.347997Z","caller":"traceutil/trace.go:171","msg":"trace[2074510205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2130; }","duration":"164.035055ms","start":"2026-07-30T23:48:53.183948Z","end":"2026-07-30T23:48:53.347983Z","steps":["trace[2074510205] 'agreement among raft nodes before linearized reading'  (duration: 163.80685ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T23:48:53.360269Z","caller":"traceutil/trace.go:171","msg":"trace[39530681] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"175.723347ms","start":"2026-07-30T23:48:53.184535Z","end":"2026-07-30T23:48:53.360259Z","steps":["trace[39530681] 'process raft request'  (duration: 175.646156ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T23:48:53.360356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.266368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-30T23:48:53.360398Z","caller":"traceutil/trace.go:171","msg":"trace[2077964614] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2131; }","duration":"176.326699ms","start":"2026-07-30T23:48:53.18406Z","end":"2026-07-30T23:48:53.360387Z","steps":["trace[2077964614] 'agreement among raft nodes before linearized reading'  (duration: 176.217957ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T23:48:59.511094Z","caller":"traceutil/trace.go:171","msg":"trace[1819659446] linearizableReadLoop","detail":"{readStateIndex:2269; appliedIndex:2267; }","duration":"115.377619ms","start":"2026-07-30T23:48:59.39569Z","end":"2026-07-30T23:48:59.511068Z","steps":["trace[1819659446] 'read index received'  (duration: 6.24712ms)","trace[1819659446] 'applied index is now lower than readState.Index'  (duration: 109.129319ms)"],"step_count":2}
{"level":"info","ts":"2026-07-30T23:48:59.511273Z","caller":"traceutil/trace.go:171","msg":"trace[1176690758] transaction","detail":"{read_only:false; response_revision:2192; number_of_response:1; }","duration":"133.034494ms","start":"2026-07-30T23:48:59.378226Z","end":"2026-07-30T23:48:59.511261Z","steps":["trace[1176690758] 'process raft request'  (duration: 132.015442ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T23:48:59.511426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.725896ms","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-07-30T23:48:59.511516Z","caller":"traceutil/trace.go:171","msg":"trace[486729994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2192; }","duration":"115.866589ms","start":"2026-07-30T23:48:59.395624Z","end":"2026-07-30T23:48:59.51149Z","steps":["trace[486729994] 'agreement among raft nodes before linearized reading'  (duration: 115.664214ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T23:48:59.738343Z","caller":"traceutil/trace.go:171","msg":"trace[2093392422] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"182.257651ms","start":"2026-07-30T23:48:59.556048Z","end":"2026-07-30T23:48:59.738306Z","steps":["trace[2093392422] 'process raft request'  (duration: 164.529524ms)","trace[2093392422] 'compare'  (duration: 17.461562ms)"],"step_count":2}
{"level":"info","ts":"2026-07-30T23:49:23.778152Z","caller":"traceutil/trace.go:171","msg":"trace[387850884] linearizableReadLoop","detail":"{readStateIndex:2455; appliedIndex:2453; }","duration":"159.327993ms","start":"2026-07-30T23:49:23.618803Z","end":"2026-07-30T23:49:23.778131Z","steps":["trace[387850884] 'read index received'  (duration: 18.657206ms)","trace[387850884] 'applied index is now lower than readState.Index'  (duration: 140.669727ms)"],"step_count":2}
{"level":"info","ts":"2026-07-30T23:49:23.778295Z","caller":"traceutil/trace.go:171","msg":"trace[1657982373] transaction","detail":"{read_only:false; response_revision:2372; number_of_response:1; }","duration":"181.394899ms","start":"2026-07-30T23:49:23.596889Z","end":"2026-07-30T23:49:23.778284Z","steps":["trace[1657982373] 'process raft request'  (duration: 179.645854ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T23:49:23.778368Z","caller":"traceutil/trace.go:171","msg":"trace[469518197] transaction","detail":"{read_only:false; response_revision:2373; number_of_response:1; }","duration":"130.478576ms","start":"2026-07-30T23:49:23.647851Z","end":"2026-07-30T23:49:23.778329Z","steps":["trace[469518197] 'process raft request'  (duration: 130.238401ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T23:49:23.778944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.113109ms","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-07-30T23:49:23.77905Z","caller":"traceutil/trace.go:171","msg":"trace[394633562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2373; }","duration":"160.269913ms","start":"2026-07-30T23:49:23.618758Z","end":"2026-07-30T23:49:23.779028Z","steps":["trace[394633562] 'agreement among raft nodes before linearized reading'  (duration: 159.778443ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T23:49:23.99589Z","caller":"traceutil/trace.go:171","msg":"trace[92188712] linearizableReadLoop","detail":"{readStateIndex:2458; appliedIndex:2457; }","duration":"122.017883ms","start":"2026-07-30T23:49:23.873839Z","end":"2026-07-30T23:49:23.995857Z","steps":["trace[92188712] 'read index received'  (duration: 103.362387ms)","trace[92188712] 'applied index is now lower than readState.Index'  (duration: 18.654496ms)"],"step_count":2}
{"level":"info","ts":"2026-07-30T23:49:23.995921Z","caller":"traceutil/trace.go:171","msg":"trace[867980461] transaction","detail":"{read_only:false; response_revision:2375; number_of_response:1; }","duration":"211.456292ms","start":"2026-07-30T23:49:23.784442Z","end":"2026-07-30T23:49:23.995899Z","steps":["trace[867980461] 'process raft request'  (duration: 192.855507ms)","trace[867980461] 'compare'  (duration: 18.443372ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-30T23:49:23.996102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.247657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-07-30T23:49:23.996136Z","caller":"traceutil/trace.go:171","msg":"trace[1590603984] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2375; }","duration":"122.347359ms","start":"2026-07-30T23:49:23.873776Z","end":"2026-07-30T23:49:23.996124Z","steps":["trace[1590603984] 'agreement among raft nodes before linearized reading'  (duration: 122.195776ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T23:49:24.661822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.28345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12632"}
{"level":"info","ts":"2026-07-30T23:49:24.662111Z","caller":"traceutil/trace.go:171","msg":"trace[901583347] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2379; }","duration":"169.566676ms","start":"2026-07-30T23:49:24.492509Z","end":"2026-07-30T23:49:24.662075Z","steps":["trace[901583347] 'range keys from in-memory index tree'  (duration: 169.008544ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T23:49:25.147283Z","caller":"traceutil/trace.go:171","msg":"trace[2097654532] transaction","detail":"{read_only:false; response_revision:2382; number_of_response:1; }","duration":"133.406348ms","start":"2026-07-30T23:49:25.013834Z","end":"2026-07-30T23:49:25.147241Z","steps":["trace[2097654532] 'process raft request'  (duration: 130.251872ms)"],"step_count":1}
{"level":"info","ts":"2026-07-30T23:49:25.147272Z","caller":"traceutil/trace.go:171","msg":"trace[1179594603] linearizableReadLoop","detail":"{readStateIndex:2465; appliedIndex:2464; }","duration":"109.050704ms","start":"2026-07-30T23:49:25.038174Z","end":"2026-07-30T23:49:25.147225Z","steps":["trace[1179594603] 'read index received'  (duration: 105.906029ms)","trace[1179594603] 'applied index is now lower than readState.Index'  (duration: 3.142965ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-30T23:49:25.147525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.32989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"}
{"level":"info","ts":"2026-07-30T23:49:25.147594Z","caller":"traceutil/trace.go:171","msg":"trace[279438963] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2382; }","duration":"109.453662ms","start":"2026-07-30T23:49:25.038116Z","end":"2026-07-30T23:49:25.14757Z","steps":["trace[279438963] 'agreement among raft nodes before linearized reading'  (duration: 109.213197ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T23:51:45.772442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.511972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12462"}
{"level":"info","ts":"2026-07-30T23:51:45.772545Z","caller":"traceutil/trace.go:171","msg":"trace[1922246181] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3504; }","duration":"386.663346ms","start":"2026-07-30T23:51:45.385862Z","end":"2026-07-30T23:51:45.772526Z","steps":["trace[1922246181] 'range keys from in-memory index tree'  (duration: 386.251927ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T23:51:45.772586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:51:45.385823Z","time spent":"386.753547ms","remote":"127.0.0.1:45454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12484,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "}
{"level":"warn","ts":"2026-07-30T23:51:45.77243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.108352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/valkey-node-0.18c7364dd27f4dd6\" ","response":"range_response_count:1 size:768"}
{"level":"info","ts":"2026-07-30T23:51:45.772867Z","caller":"traceutil/trace.go:171","msg":"trace[1480607870] range","detail":"{range_begin:/registry/events/openstack/valkey-node-0.18c7364dd27f4dd6; range_end:; response_count:1; response_revision:3504; }","duration":"517.602962ms","start":"2026-07-30T23:51:45.255248Z","end":"2026-07-30T23:51:45.772851Z","steps":["trace[1480607870] 'range keys from in-memory index tree'  (duration: 516.926459ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T23:51:45.772912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:51:45.255224Z","time spent":"517.676813ms","remote":"127.0.0.1:45310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":790,"request content":"key:\"/registry/events/openstack/valkey-node-0.18c7364dd27f4dd6\" "}
{"level":"info","ts":"2026-07-30T23:51:45.798016Z","caller":"traceutil/trace.go:171","msg":"trace[1447385900] transaction","detail":"{read_only:false; response_revision:3505; number_of_response:1; }","duration":"389.974392ms","start":"2026-07-30T23:51:45.407994Z","end":"2026-07-30T23:51:45.797968Z","steps":["trace[1447385900] 'process raft request'  (duration: 389.675316ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-30T23:51:45.798237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T23:51:45.40797Z","time spent":"390.155236ms","remote":"127.0.0.1:45526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:3435 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-07-30T23:56:02.715242Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3191}
{"level":"info","ts":"2026-07-30T23:56:02.81633Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3191,"took":"99.952154ms","hash":2311678096,"current-db-size-bytes":36593664,"current-db-size":"37 MB","current-db-size-in-use-bytes":10215424,"current-db-size-in-use":"10 MB"}
{"level":"info","ts":"2026-07-30T23:56:02.816434Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2311678096,"revision":3191,"compact-revision":-1}
{"level":"info","ts":"2026-07-31T00:01:02.721496Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5168}
{"level":"info","ts":"2026-07-31T00:01:02.774709Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5168,"took":"52.185253ms","hash":1765202068,"current-db-size-bytes":36593664,"current-db-size":"37 MB","current-db-size-in-use-bytes":11702272,"current-db-size-in-use":"12 MB"}
{"level":"info","ts":"2026-07-31T00:01:02.77478Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1765202068,"revision":5168,"compact-revision":3191}
{"level":"info","ts":"2026-07-31T00:05:33.051196Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"71d28e9ac1bc4e5d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-31T00:05:33.057351Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-07-31T00:05:33.057533Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-07-31T00:06:02.726992Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7486}
{"level":"info","ts":"2026-07-31T00:06:02.789944Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7486,"took":"61.542669ms","hash":3378502556,"current-db-size-bytes":36593664,"current-db-size":"37 MB","current-db-size-in-use-bytes":13950976,"current-db-size-in-use":"14 MB"}
{"level":"info","ts":"2026-07-31T00:06:02.790022Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3378502556,"revision":7486,"compact-revision":5168}
{"level":"info","ts":"2026-07-31T00:11:02.734296Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9958}
{"level":"info","ts":"2026-07-31T00:11:02.793471Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9958,"took":"57.646256ms","hash":3654452722,"current-db-size-bytes":36593664,"current-db-size":"37 MB","current-db-size-in-use-bytes":14516224,"current-db-size-in-use":"14 MB"}
{"level":"info","ts":"2026-07-31T00:11:02.793569Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3654452722,"revision":9958,"compact-revision":7486}
{"level":"warn","ts":"2026-07-31T00:13:08.366201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.300702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-31T00:13:08.366285Z","caller":"traceutil/trace.go:171","msg":"trace[537584214] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13343; }","duration":"182.399165ms","start":"2026-07-31T00:13:08.18387Z","end":"2026-07-31T00:13:08.36627Z","steps":["trace[537584214] 'range keys from in-memory index tree'  (duration: 182.204991ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:13:08.366257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.936672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"}
{"level":"info","ts":"2026-07-31T00:13:08.36635Z","caller":"traceutil/trace.go:171","msg":"trace[1297101546] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:13343; }","duration":"198.049086ms","start":"2026-07-31T00:13:08.168284Z","end":"2026-07-31T00:13:08.366333Z","steps":["trace[1297101546] 'range keys from in-memory index tree'  (duration: 197.748089ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:13:08.502524Z","caller":"traceutil/trace.go:171","msg":"trace[293478814] transaction","detail":"{read_only:false; response_revision:13344; number_of_response:1; }","duration":"131.780588ms","start":"2026-07-31T00:13:08.370718Z","end":"2026-07-31T00:13:08.502499Z","steps":["trace[293478814] 'process raft request'  (duration: 131.605215ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:14:35.476441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.527051ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5646845109337265365 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:14439 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-07-31T00:14:35.476807Z","caller":"traceutil/trace.go:171","msg":"trace[1615499206] linearizableReadLoop","detail":"{readStateIndex:14895; appliedIndex:14894; }","duration":"292.905332ms","start":"2026-07-31T00:14:35.18366Z","end":"2026-07-31T00:14:35.476565Z","steps":["trace[1615499206] 'read index received'  (duration: 31.111915ms)","trace[1615499206] 'applied index is now lower than readState.Index'  (duration: 261.791717ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T00:14:35.476923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.25ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-31T00:14:35.476985Z","caller":"traceutil/trace.go:171","msg":"trace[1322481849] transaction","detail":"{read_only:false; response_revision:14452; number_of_response:1; }","duration":"396.250151ms","start":"2026-07-31T00:14:35.080459Z","end":"2026-07-31T00:14:35.476709Z","steps":["trace[1322481849] 'process raft request'  (duration: 134.350441ms)","trace[1322481849] 'compare'  (duration: 261.299106ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T00:14:35.477023Z","caller":"traceutil/trace.go:171","msg":"trace[855523190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14452; }","duration":"293.378713ms","start":"2026-07-31T00:14:35.183619Z","end":"2026-07-31T00:14:35.476998Z","steps":["trace[855523190] 'agreement among raft nodes before linearized reading'  (duration: 293.22914ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:14:35.47715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T00:14:35.080433Z","time spent":"396.64076ms","remote":"127.0.0.1:45526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:14439 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-07-31T00:14:35.740867Z","caller":"traceutil/trace.go:171","msg":"trace[1738409490] linearizableReadLoop","detail":"{readStateIndex:14896; appliedIndex:14895; }","duration":"263.955546ms","start":"2026-07-31T00:14:35.476887Z","end":"2026-07-31T00:14:35.740842Z","steps":["trace[1738409490] 'read index received'  (duration: 199.966828ms)","trace[1738409490] 'applied index is now lower than readState.Index'  (duration: 63.987668ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T00:14:35.740983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.454019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-31T00:14:35.740958Z","caller":"traceutil/trace.go:171","msg":"trace[1053532560] transaction","detail":"{read_only:false; response_revision:14453; number_of_response:1; }","duration":"449.147913ms","start":"2026-07-31T00:14:35.29175Z","end":"2026-07-31T00:14:35.740897Z","steps":["trace[1053532560] 'process raft request'  (duration: 385.191435ms)","trace[1053532560] 'compare'  (duration: 63.776374ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T00:14:35.741057Z","caller":"traceutil/trace.go:171","msg":"trace[167651576] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:14453; }","duration":"282.578063ms","start":"2026-07-31T00:14:35.458461Z","end":"2026-07-31T00:14:35.741039Z","steps":["trace[167651576] 'agreement among raft nodes before linearized reading'  (duration: 282.427438ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:14:35.741101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.411451ms","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-07-31T00:14:35.741187Z","caller":"traceutil/trace.go:171","msg":"trace[424046067] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14453; }","duration":"454.537495ms","start":"2026-07-31T00:14:35.28663Z","end":"2026-07-31T00:14:35.741168Z","steps":["trace[424046067] 'agreement among raft nodes before linearized reading'  (duration: 454.274968ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:14:35.741207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.637847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"warn","ts":"2026-07-31T00:14:35.741219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T00:14:35.291732Z","time spent":"449.348338ms","remote":"127.0.0.1:45526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:14442 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-07-31T00:14:35.741234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T00:14:35.286622Z","time spent":"454.601536ms","remote":"127.0.0.1:45526","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-07-31T00:14:35.741258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.016676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-07-31T00:14:35.741308Z","caller":"traceutil/trace.go:171","msg":"trace[1130626769] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14453; }","duration":"232.77986ms","start":"2026-07-31T00:14:35.508507Z","end":"2026-07-31T00:14:35.741287Z","steps":["trace[1130626769] 'agreement among raft nodes before linearized reading'  (duration: 232.556195ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:14:35.74103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.860652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-07-31T00:14:35.741348Z","caller":"traceutil/trace.go:171","msg":"trace[1857194559] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14453; }","duration":"229.18878ms","start":"2026-07-31T00:14:35.512135Z","end":"2026-07-31T00:14:35.741323Z","steps":["trace[1857194559] 'agreement among raft nodes before linearized reading'  (duration: 228.923624ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:14:35.741381Z","caller":"traceutil/trace.go:171","msg":"trace[1081778476] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14453; }","duration":"263.257261ms","start":"2026-07-31T00:14:35.478111Z","end":"2026-07-31T00:14:35.741369Z","steps":["trace[1081778476] 'agreement among raft nodes before linearized reading'  (duration: 262.879023ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:14:35.741506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.860565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-07-31T00:14:35.741538Z","caller":"traceutil/trace.go:171","msg":"trace[785238205] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14453; }","duration":"456.928787ms","start":"2026-07-31T00:14:35.2846Z","end":"2026-07-31T00:14:35.741529Z","steps":["trace[785238205] 'agreement among raft nodes before linearized reading'  (duration: 456.346163ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:14:35.741566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T00:14:35.284579Z","time spent":"456.978698ms","remote":"127.0.0.1:45526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-07-31T00:16:02.741618Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12293}
{"level":"info","ts":"2026-07-31T00:16:02.805337Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12293,"took":"60.059012ms","hash":2411745328,"current-db-size-bytes":36593664,"current-db-size":"37 MB","current-db-size-in-use-bytes":17526784,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-07-31T00:16:02.805433Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2411745328,"revision":12293,"compact-revision":9958}
{"level":"info","ts":"2026-07-31T00:21:02.749306Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15007}
{"level":"info","ts":"2026-07-31T00:21:02.832483Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15007,"took":"80.763811ms","hash":4030746239,"current-db-size-bytes":36593664,"current-db-size":"37 MB","current-db-size-in-use-bytes":17842176,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-07-31T00:21:02.832561Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4030746239,"revision":15007,"compact-revision":12293}
{"level":"info","ts":"2026-07-31T00:25:51.045371Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"71d28e9ac1bc4e5d","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-31T00:25:51.050819Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-07-31T00:25:51.050881Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-07-31T00:26:02.755519Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17478}
{"level":"info","ts":"2026-07-31T00:26:02.829654Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17478,"took":"71.839173ms","hash":2456311661,"current-db-size-bytes":36593664,"current-db-size":"37 MB","current-db-size-in-use-bytes":17772544,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-07-31T00:26:02.829802Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2456311661,"revision":17478,"compact-revision":15007}
{"level":"info","ts":"2026-07-31T00:27:09.625735Z","caller":"traceutil/trace.go:171","msg":"trace[1129879039] linearizableReadLoop","detail":"{readStateIndex:20656; appliedIndex:20655; }","duration":"155.415497ms","start":"2026-07-31T00:27:09.470298Z","end":"2026-07-31T00:27:09.625713Z","steps":["trace[1129879039] 'read index received'  (duration: 155.195912ms)","trace[1129879039] 'applied index is now lower than readState.Index'  (duration: 216.084µs)"],"step_count":2}
{"level":"info","ts":"2026-07-31T00:27:09.625807Z","caller":"traceutil/trace.go:171","msg":"trace[180881800] transaction","detail":"{read_only:false; response_revision:20042; number_of_response:1; }","duration":"165.706744ms","start":"2026-07-31T00:27:09.460059Z","end":"2026-07-31T00:27:09.625765Z","steps":["trace[180881800] 'process raft request'  (duration: 165.52116ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:27:09.62601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.478477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-07-31T00:27:09.625995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.659581ms","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-07-31T00:27:09.626047Z","caller":"traceutil/trace.go:171","msg":"trace[52146121] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20042; }","duration":"151.551438ms","start":"2026-07-31T00:27:09.474485Z","end":"2026-07-31T00:27:09.626037Z","steps":["trace[52146121] 'agreement among raft nodes before linearized reading'  (duration: 151.408205ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:27:09.626066Z","caller":"traceutil/trace.go:171","msg":"trace[1047919527] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20042; }","duration":"155.794474ms","start":"2026-07-31T00:27:09.470255Z","end":"2026-07-31T00:27:09.626049Z","steps":["trace[1047919527] 'agreement among raft nodes before linearized reading'  (duration: 155.57915ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:27:09.626144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.360991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"}
{"level":"info","ts":"2026-07-31T00:27:09.626209Z","caller":"traceutil/trace.go:171","msg":"trace[770282636] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20042; }","duration":"135.437373ms","start":"2026-07-31T00:27:09.490748Z","end":"2026-07-31T00:27:09.626185Z","steps":["trace[770282636] 'agreement among raft nodes before linearized reading'  (duration: 135.202848ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:27:09.771182Z","caller":"traceutil/trace.go:171","msg":"trace[1304748809] transaction","detail":"{read_only:false; response_revision:20047; number_of_response:1; }","duration":"131.757359ms","start":"2026-07-31T00:27:09.639399Z","end":"2026-07-31T00:27:09.771156Z","steps":["trace[1304748809] 'process raft request'  (duration: 131.713548ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:27:09.771297Z","caller":"traceutil/trace.go:171","msg":"trace[188979996] transaction","detail":"{read_only:false; response_revision:20044; number_of_response:1; }","duration":"141.855713ms","start":"2026-07-31T00:27:09.629414Z","end":"2026-07-31T00:27:09.77127Z","steps":["trace[188979996] 'process raft request'  (duration: 141.495226ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:27:09.771386Z","caller":"traceutil/trace.go:171","msg":"trace[420288588] transaction","detail":"{read_only:false; response_revision:20045; number_of_response:1; }","duration":"135.21883ms","start":"2026-07-31T00:27:09.636134Z","end":"2026-07-31T00:27:09.771352Z","steps":["trace[420288588] 'process raft request'  (duration: 134.906124ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:27:09.771396Z","caller":"traceutil/trace.go:171","msg":"trace[1131473504] transaction","detail":"{read_only:false; response_revision:20046; number_of_response:1; }","duration":"135.214679ms","start":"2026-07-31T00:27:09.636154Z","end":"2026-07-31T00:27:09.771368Z","steps":["trace[1131473504] 'process raft request'  (duration: 134.927903ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:27:10.287745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.745411ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5646845109337287969 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:19952 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-31T00:27:10.287986Z","caller":"traceutil/trace.go:171","msg":"trace[984140111] linearizableReadLoop","detail":"{readStateIndex:20662; appliedIndex:20661; }","duration":"418.20923ms","start":"2026-07-31T00:27:09.869746Z","end":"2026-07-31T00:27:10.287955Z","steps":["trace[984140111] 'read index received'  (duration: 161.422087ms)","trace[984140111] 'applied index is now lower than readState.Index'  (duration: 256.784112ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T00:27:10.288016Z","caller":"traceutil/trace.go:171","msg":"trace[1571796806] transaction","detail":"{read_only:false; response_revision:20048; number_of_response:1; }","duration":"456.056484ms","start":"2026-07-31T00:27:09.831932Z","end":"2026-07-31T00:27:10.287989Z","steps":["trace[1571796806] 'process raft request'  (duration: 198.973766ms)","trace[1571796806] 'compare'  (duration: 256.586028ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T00:27:10.288119Z","caller":"traceutil/trace.go:171","msg":"trace[1852677371] transaction","detail":"{read_only:false; response_revision:20049; number_of_response:1; }","duration":"311.320662ms","start":"2026-07-31T00:27:09.97678Z","end":"2026-07-31T00:27:10.2881Z","steps":["trace[1852677371] 'process raft request'  (duration: 311.081578ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:27:10.288148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T00:27:09.831887Z","time spent":"456.180066ms","remote":"127.0.0.1:45526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:19952 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-07-31T00:27:10.288226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T00:27:09.976746Z","time spent":"311.424305ms","remote":"127.0.0.1:45526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:20033 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-07-31T00:27:10.288232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.874307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"warn","ts":"2026-07-31T00:27:10.288216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.964188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T00:27:10.288282Z","caller":"traceutil/trace.go:171","msg":"trace[715514089] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20049; }","duration":"274.950999ms","start":"2026-07-31T00:27:10.013318Z","end":"2026-07-31T00:27:10.288269Z","steps":["trace[715514089] 'agreement among raft nodes before linearized reading'  (duration: 274.792606ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:27:10.288324Z","caller":"traceutil/trace.go:171","msg":"trace[824327596] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20049; }","duration":"104.128601ms","start":"2026-07-31T00:27:10.184172Z","end":"2026-07-31T00:27:10.2883Z","steps":["trace[824327596] 'agreement among raft nodes before linearized reading'  (duration: 103.956618ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:27:10.288378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.636238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-52zmq\" ","response":"range_response_count:1 size:20668"}
{"level":"info","ts":"2026-07-31T00:27:10.288412Z","caller":"traceutil/trace.go:171","msg":"trace[1139557910] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-52zmq; range_end:; response_count:1; response_revision:20049; }","duration":"418.700659ms","start":"2026-07-31T00:27:09.869699Z","end":"2026-07-31T00:27:10.2884Z","steps":["trace[1139557910] 'agreement among raft nodes before linearized reading'  (duration: 418.345132ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:27:10.288398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.111091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-07-31T00:27:10.288386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.904011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T00:27:10.288519Z","caller":"traceutil/trace.go:171","msg":"trace[1856224920] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:20049; }","duration":"100.380556ms","start":"2026-07-31T00:27:10.188118Z","end":"2026-07-31T00:27:10.288498Z","steps":["trace[1856224920] 'agreement among raft nodes before linearized reading'  (duration: 100.07912ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:27:10.288559Z","caller":"traceutil/trace.go:171","msg":"trace[1522381189] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:20049; }","duration":"127.104545ms","start":"2026-07-31T00:27:10.161417Z","end":"2026-07-31T00:27:10.288521Z","steps":["trace[1522381189] 'agreement among raft nodes before linearized reading'  (duration: 126.799129ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:27:10.288428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T00:27:09.86968Z","time spent":"418.74527ms","remote":"127.0.0.1:45454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20690,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-52zmq\" "}
{"level":"warn","ts":"2026-07-31T00:27:10.290065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.088901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-sh59f\" ","response":"range_response_count:1 size:22022"}
{"level":"info","ts":"2026-07-31T00:27:10.290128Z","caller":"traceutil/trace.go:171","msg":"trace[232468615] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-sh59f; range_end:; response_count:1; response_revision:20049; }","duration":"106.184763ms","start":"2026-07-31T00:27:10.183924Z","end":"2026-07-31T00:27:10.290109Z","steps":["trace[232468615] 'agreement among raft nodes before linearized reading'  (duration: 104.220633ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:27:32.517542Z","caller":"traceutil/trace.go:171","msg":"trace[608710654] transaction","detail":"{read_only:false; response_revision:20335; number_of_response:1; }","duration":"115.816966ms","start":"2026-07-31T00:27:32.401688Z","end":"2026-07-31T00:27:32.517505Z","steps":["trace[608710654] 'process raft request'  (duration: 38.65138ms)","trace[608710654] 'compare'  (duration: 76.933242ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T00:28:48.393996Z","caller":"traceutil/trace.go:171","msg":"trace[1225599530] transaction","detail":"{read_only:false; response_revision:20933; number_of_response:1; }","duration":"112.860227ms","start":"2026-07-31T00:28:48.2811Z","end":"2026-07-31T00:28:48.39396Z","steps":["trace[1225599530] 'process raft request'  (duration: 112.609402ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:28:48.443188Z","caller":"traceutil/trace.go:171","msg":"trace[584264491] transaction","detail":"{read_only:false; response_revision:20934; number_of_response:1; }","duration":"160.100421ms","start":"2026-07-31T00:28:48.283058Z","end":"2026-07-31T00:28:48.443158Z","steps":["trace[584264491] 'process raft request'  (duration: 159.962898ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:28:48.705057Z","caller":"traceutil/trace.go:171","msg":"trace[505411342] transaction","detail":"{read_only:false; response_revision:20936; number_of_response:1; }","duration":"102.971369ms","start":"2026-07-31T00:28:48.602061Z","end":"2026-07-31T00:28:48.705032Z","steps":["trace[505411342] 'process raft request'  (duration: 102.494369ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:28:48.956355Z","caller":"traceutil/trace.go:171","msg":"trace[19942632] transaction","detail":"{read_only:false; response_revision:20937; number_of_response:1; }","duration":"247.626578ms","start":"2026-07-31T00:28:48.708706Z","end":"2026-07-31T00:28:48.956332Z","steps":["trace[19942632] 'process raft request'  (duration: 247.470485ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:28:49.108193Z","caller":"traceutil/trace.go:171","msg":"trace[1877011081] linearizableReadLoop","detail":"{readStateIndex:21580; appliedIndex:21578; }","duration":"241.060464ms","start":"2026-07-31T00:28:48.867111Z","end":"2026-07-31T00:28:49.108172Z","steps":["trace[1877011081] 'read index received'  (duration: 89.138088ms)","trace[1877011081] 'applied index is now lower than readState.Index'  (duration: 151.921396ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T00:28:49.108513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.349931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"warn","ts":"2026-07-31T00:28:49.108546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.661387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12463"}
{"level":"info","ts":"2026-07-31T00:28:49.108558Z","caller":"traceutil/trace.go:171","msg":"trace[53795328] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:20938; }","duration":"187.446233ms","start":"2026-07-31T00:28:48.921102Z","end":"2026-07-31T00:28:49.108548Z","steps":["trace[53795328] 'agreement among raft nodes before linearized reading'  (duration: 187.32685ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:28:49.108583Z","caller":"traceutil/trace.go:171","msg":"trace[1455924960] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:20938; }","duration":"185.739228ms","start":"2026-07-31T00:28:48.922834Z","end":"2026-07-31T00:28:49.108573Z","steps":["trace[1455924960] 'agreement among raft nodes before linearized reading'  (duration: 185.609406ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:28:49.108794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.691328ms","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-07-31T00:28:49.108801Z","caller":"traceutil/trace.go:171","msg":"trace[592105390] transaction","detail":"{read_only:false; response_revision:20938; number_of_response:1; }","duration":"310.887024ms","start":"2026-07-31T00:28:48.797771Z","end":"2026-07-31T00:28:49.108658Z","steps":["trace[592105390] 'process raft request'  (duration: 286.579593ms)","trace[592105390] 'compare'  (duration: 23.496415ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T00:28:49.108841Z","caller":"traceutil/trace.go:171","msg":"trace[330023806] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20938; }","duration":"241.772218ms","start":"2026-07-31T00:28:48.86706Z","end":"2026-07-31T00:28:49.108832Z","steps":["trace[330023806] 'agreement among raft nodes before linearized reading'  (duration: 241.287679ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:28:49.10896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-31T00:28:48.797743Z","time spent":"311.129988ms","remote":"127.0.0.1:45526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:20926 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-07-31T00:28:49.27945Z","caller":"traceutil/trace.go:171","msg":"trace[1110397398] linearizableReadLoop","detail":"{readStateIndex:21581; appliedIndex:21580; }","duration":"165.562941ms","start":"2026-07-31T00:28:49.113858Z","end":"2026-07-31T00:28:49.279421Z","steps":["trace[1110397398] 'read index received'  (duration: 129.126285ms)","trace[1110397398] 'applied index is now lower than readState.Index'  (duration: 36.435706ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T00:28:49.279684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.814366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:15225"}
{"level":"info","ts":"2026-07-31T00:28:49.27976Z","caller":"traceutil/trace.go:171","msg":"trace[623564561] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:20939; }","duration":"165.920018ms","start":"2026-07-31T00:28:49.113823Z","end":"2026-07-31T00:28:49.279743Z","steps":["trace[623564561] 'agreement among raft nodes before linearized reading'  (duration: 165.699944ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:28:49.279541Z","caller":"traceutil/trace.go:171","msg":"trace[102675141] transaction","detail":"{read_only:false; response_revision:20939; number_of_response:1; }","duration":"166.620302ms","start":"2026-07-31T00:28:49.11288Z","end":"2026-07-31T00:28:49.279501Z","steps":["trace[102675141] 'process raft request'  (duration: 130.068355ms)","trace[102675141] 'compare'  (duration: 36.334893ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T00:28:49.537038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.394415ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5646845109337290130 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" mod_revision:20928 > success:<request_put:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" value_size:452 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-31T00:28:49.537151Z","caller":"traceutil/trace.go:171","msg":"trace[1655299812] linearizableReadLoop","detail":"{readStateIndex:21582; appliedIndex:21581; }","duration":"200.793403ms","start":"2026-07-31T00:28:49.336338Z","end":"2026-07-31T00:28:49.537132Z","steps":["trace[1655299812] 'read index received'  (duration: 56.171054ms)","trace[1655299812] 'applied index is now lower than readState.Index'  (duration: 144.621259ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T00:28:49.53728Z","caller":"traceutil/trace.go:171","msg":"trace[725311409] transaction","detail":"{read_only:false; response_revision:20940; number_of_response:1; }","duration":"253.364423ms","start":"2026-07-31T00:28:49.283865Z","end":"2026-07-31T00:28:49.537229Z","steps":["trace[725311409] 'process raft request'  (duration: 108.687322ms)","trace[725311409] 'compare'  (duration: 144.201141ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T00:28:49.537405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.042187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T00:28:49.537498Z","caller":"traceutil/trace.go:171","msg":"trace[1002193910] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:20940; }","duration":"201.19849ms","start":"2026-07-31T00:28:49.336276Z","end":"2026-07-31T00:28:49.537474Z","steps":["trace[1002193910] 'agreement among raft nodes before linearized reading'  (duration: 201.014817ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:28:49.537929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.652356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"}
{"level":"info","ts":"2026-07-31T00:28:49.537962Z","caller":"traceutil/trace.go:171","msg":"trace[612583678] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:20940; }","duration":"132.731608ms","start":"2026-07-31T00:28:49.405223Z","end":"2026-07-31T00:28:49.537955Z","steps":["trace[612583678] 'agreement among raft nodes before linearized reading'  (duration: 132.092585ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:28:49.799291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.286862ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5646845109337290137 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:20909 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:406 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >>","response":"size:18"}
{"level":"info","ts":"2026-07-31T00:28:49.79942Z","caller":"traceutil/trace.go:171","msg":"trace[1399635335] linearizableReadLoop","detail":"{readStateIndex:21583; appliedIndex:21582; }","duration":"254.917185ms","start":"2026-07-31T00:28:49.544486Z","end":"2026-07-31T00:28:49.799404Z","steps":["trace[1399635335] 'read index received'  (duration: 108.361876ms)","trace[1399635335] 'applied index is now lower than readState.Index'  (duration: 146.554159ms)"],"step_count":2}
{"level":"info","ts":"2026-07-31T00:28:49.799535Z","caller":"traceutil/trace.go:171","msg":"trace[742725162] transaction","detail":"{read_only:false; response_revision:20941; number_of_response:1; }","duration":"255.169979ms","start":"2026-07-31T00:28:49.54432Z","end":"2026-07-31T00:28:49.79949Z","steps":["trace[742725162] 'process raft request'  (duration: 108.58797ms)","trace[742725162] 'compare'  (duration: 146.14699ms)"],"step_count":2}
{"level":"warn","ts":"2026-07-31T00:28:49.799642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.141749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:15225"}
{"level":"warn","ts":"2026-07-31T00:28:49.799642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.849239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-07-31T00:28:49.799719Z","caller":"traceutil/trace.go:171","msg":"trace[1342273623] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:20941; }","duration":"255.219181ms","start":"2026-07-31T00:28:49.544482Z","end":"2026-07-31T00:28:49.799701Z","steps":["trace[1342273623] 'agreement among raft nodes before linearized reading'  (duration: 255.003116ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:28:49.799727Z","caller":"traceutil/trace.go:171","msg":"trace[2145266026] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:20941; }","duration":"123.054854ms","start":"2026-07-31T00:28:49.676655Z","end":"2026-07-31T00:28:49.79971Z","steps":["trace[2145266026] 'agreement among raft nodes before linearized reading'  (duration: 122.85696ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:28:50.280763Z","caller":"traceutil/trace.go:171","msg":"trace[1469837927] linearizableReadLoop","detail":"{readStateIndex:21585; appliedIndex:21583; }","duration":"165.756145ms","start":"2026-07-31T00:28:50.114984Z","end":"2026-07-31T00:28:50.28074Z","steps":["trace[1469837927] 'read index received'  (duration: 165.47747ms)","trace[1469837927] 'applied index is now lower than readState.Index'  (duration: 277.845µs)"],"step_count":2}
{"level":"info","ts":"2026-07-31T00:28:50.28081Z","caller":"traceutil/trace.go:171","msg":"trace[56883601] transaction","detail":"{read_only:false; response_revision:20942; number_of_response:1; }","duration":"172.189044ms","start":"2026-07-31T00:28:50.108588Z","end":"2026-07-31T00:28:50.280777Z","steps":["trace[56883601] 'process raft request'  (duration: 171.939269ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:28:50.280854Z","caller":"traceutil/trace.go:171","msg":"trace[1315878225] transaction","detail":"{read_only:false; response_revision:20943; number_of_response:1; }","duration":"172.210235ms","start":"2026-07-31T00:28:50.108608Z","end":"2026-07-31T00:28:50.280818Z","steps":["trace[1315878225] 'process raft request'  (duration: 172.090242ms)"],"step_count":1}
{"level":"warn","ts":"2026-07-31T00:28:50.281018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.705764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"}
{"level":"warn","ts":"2026-07-31T00:28:50.281025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.01893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-07-31T00:28:50.281063Z","caller":"traceutil/trace.go:171","msg":"trace[1871784036] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20943; }","duration":"116.803156ms","start":"2026-07-31T00:28:50.16425Z","end":"2026-07-31T00:28:50.281053Z","steps":["trace[1871784036] 'agreement among raft nodes before linearized reading'  (duration: 116.622153ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:28:50.281101Z","caller":"traceutil/trace.go:171","msg":"trace[1318800918] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20943; }","duration":"166.130683ms","start":"2026-07-31T00:28:50.114952Z","end":"2026-07-31T00:28:50.281082Z","steps":["trace[1318800918] 'agreement among raft nodes before linearized reading'  (duration: 165.880787ms)"],"step_count":1}
{"level":"info","ts":"2026-07-31T00:30:08.970319Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000578b.wal"}
{"level":"info","ts":"2026-07-31T00:31:02.762794Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19507}
{"level":"info","ts":"2026-07-31T00:31:02.835631Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19507,"took":"70.064664ms","hash":2351828929,"current-db-size-bytes":36593664,"current-db-size":"37 MB","current-db-size-in-use-bytes":19808256,"current-db-size-in-use":"20 MB"}
{"level":"info","ts":"2026-07-31T00:31:02.835705Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2351828929,"revision":19507,"compact-revision":17478}
{"level":"info","ts":"2026-07-31T00:36:02.76927Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22083}
{"level":"info","ts":"2026-07-31T00:36:02.862694Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22083,"took":"90.947746ms","hash":1762678155,"current-db-size-bytes":36593664,"current-db-size":"37 MB","current-db-size-in-use-bytes":16732160,"current-db-size-in-use":"17 MB"}
{"level":"info","ts":"2026-07-31T00:36:02.862764Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1762678155,"revision":22083,"compact-revision":19507}
{"level":"info","ts":"2026-07-31T00:41:02.774949Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24236}
{"level":"info","ts":"2026-07-31T00:41:02.861682Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24236,"took":"84.271455ms","hash":4276219610,"current-db-size-bytes":36593664,"current-db-size":"37 MB","current-db-size-in-use-bytes":15286272,"current-db-size-in-use":"15 MB"}
{"level":"info","ts":"2026-07-31T00:41:02.861765Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4276219610,"revision":24236,"compact-revision":22083}
{"level":"info","ts":"2026-07-31T00:46:02.782887Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26156}
{"level":"info","ts":"2026-07-31T00:46:02.861133Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26156,"took":"76.350821ms","hash":1010219902,"current-db-size-bytes":36593664,"current-db-size":"37 MB","current-db-size-in-use-bytes":15659008,"current-db-size-in-use":"16 MB"}
{"level":"info","ts":"2026-07-31T00:46:02.861222Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1010219902,"revision":26156,"compact-revision":24236}
{"level":"info","ts":"2026-07-31T00:48:26.950052Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"71d28e9ac1bc4e5d","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-07-31T00:48:26.954389Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-07-31T00:48:26.954549Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}