{"level":"warn","ts":"2026-03-31T18:26:11.881331Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-31T18:26:11.881434Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109: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.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109: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-03-31T18:26:11.881516Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-31T18:26:11.881529Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]}
{"level":"info","ts":"2026-03-31T18:26:11.881548Z","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-03-31T18:26:11.882272Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]}
{"level":"info","ts":"2026-03-31T18:26:11.882369Z","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.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109: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-03-31T18:26:11.888047Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.366629ms"}
{"level":"info","ts":"2026-03-31T18:26:11.893762Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"}
{"level":"info","ts":"2026-03-31T18:26:11.893903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"}
{"level":"info","ts":"2026-03-31T18:26:11.89394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"}
{"level":"info","ts":"2026-03-31T18:26:11.893957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-31T18:26:11.893978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"}
{"level":"info","ts":"2026-03-31T18:26:11.894032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"}
{"level":"warn","ts":"2026-03-31T18:26:11.900608Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-31T18:26:11.902354Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-31T18:26:11.905715Z","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-03-31T18:26:11.909092Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-31T18:26:11.909358Z","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-03-31T18:26:11.909498Z","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-03-31T18:26:11.909378Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-31T18:26:11.909522Z","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-03-31T18:26:11.9131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"}
{"level":"info","ts":"2026-03-31T18:26:11.913375Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]}
{"level":"info","ts":"2026-03-31T18:26:11.916543Z","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-03-31T18:26:11.91688Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-31T18:26:11.916913Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-31T18:26:11.916951Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"}
{"level":"info","ts":"2026-03-31T18:26:11.917085Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"}
{"level":"info","ts":"2026-03-31T18:26:12.79504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"}
{"level":"info","ts":"2026-03-31T18:26:12.795135Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-31T18:26:12.795178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"}
{"level":"info","ts":"2026-03-31T18:26:12.795201Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"}
{"level":"info","ts":"2026-03-31T18:26:12.795214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"}
{"level":"info","ts":"2026-03-31T18:26:12.795231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"}
{"level":"info","ts":"2026-03-31T18:26:12.795251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"}
{"level":"info","ts":"2026-03-31T18:26:12.796232Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-31T18:26:12.797401Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-31T18:26:12.797357Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-31T18:26:12.797397Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-31T18:26:12.797866Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-31T18:26:12.798019Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-31T18:26:12.798106Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-31T18:26:12.798371Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-31T18:26:12.798426Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-31T18:26:12.799701Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-31T18:26:12.800298Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"}
{"level":"warn","ts":"2026-03-31T18:26:42.267755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.960715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"}
{"level":"info","ts":"2026-03-31T18:26:42.267926Z","caller":"traceutil/trace.go:171","msg":"trace[2128557464] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:465; }","duration":"126.18731ms","start":"2026-03-31T18:26:42.141711Z","end":"2026-03-31T18:26:42.267898Z","steps":["trace[2128557464] 'range keys from in-memory index tree'  (duration: 125.739391ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:26:44.579018Z","caller":"traceutil/trace.go:171","msg":"trace[237472349] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"126.189739ms","start":"2026-03-31T18:26:44.452781Z","end":"2026-03-31T18:26:44.578971Z","steps":["trace[237472349] 'process raft request'  (duration: 119.408012ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:26:44.579322Z","caller":"traceutil/trace.go:171","msg":"trace[731403231] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"108.185433ms","start":"2026-03-31T18:26:44.471097Z","end":"2026-03-31T18:26:44.579282Z","steps":["trace[731403231] 'process raft request'  (duration: 107.853597ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:26:50.875372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.549738ms","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-03-31T18:26:50.875635Z","caller":"traceutil/trace.go:171","msg":"trace[255963399] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:638; }","duration":"149.880614ms","start":"2026-03-31T18:26:50.725719Z","end":"2026-03-31T18:26:50.875599Z","steps":["trace[255963399] 'range keys from in-memory index tree'  (duration: 149.283032ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:26:51.630027Z","caller":"traceutil/trace.go:171","msg":"trace[135752900] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"122.289864ms","start":"2026-03-31T18:26:51.507707Z","end":"2026-03-31T18:26:51.629997Z","steps":["trace[135752900] 'process raft request'  (duration: 122.080869ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:27:17.243134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.657574ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334366701548813507 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:768 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-31T18:27:17.243348Z","caller":"traceutil/trace.go:171","msg":"trace[1281387100] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:809; }","duration":"101.554035ms","start":"2026-03-31T18:27:17.141712Z","end":"2026-03-31T18:27:17.243266Z","steps":["trace[1281387100] 'read index received'  (duration: 62.212µs)","trace[1281387100] 'applied index is now lower than readState.Index'  (duration: 101.489653ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T18:27:17.243354Z","caller":"traceutil/trace.go:171","msg":"trace[868296530] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"211.769735ms","start":"2026-03-31T18:27:17.031543Z","end":"2026-03-31T18:27:17.243313Z","steps":["trace[868296530] 'process raft request'  (duration: 43.152382ms)","trace[868296530] 'compare'  (duration: 167.490601ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T18:27:17.244519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.77161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nw4pm\" ","response":"range_response_count:1 size:3965"}
{"level":"info","ts":"2026-03-31T18:27:17.244616Z","caller":"traceutil/trace.go:171","msg":"trace[628223395] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nw4pm; range_end:; response_count:1; response_revision:783; }","duration":"102.935524ms","start":"2026-03-31T18:27:17.141657Z","end":"2026-03-31T18:27:17.244593Z","steps":["trace[628223395] 'agreement among raft nodes before linearized reading'  (duration: 101.739659ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:27:45.081349Z","caller":"traceutil/trace.go:171","msg":"trace[1207355008] linearizableReadLoop","detail":"{readStateIndex:1205; appliedIndex:1204; }","duration":"124.459809ms","start":"2026-03-31T18:27:44.956832Z","end":"2026-03-31T18:27:45.081292Z","steps":["trace[1207355008] 'read index received'  (duration: 124.303646ms)","trace[1207355008] 'applied index is now lower than readState.Index'  (duration: 154.403µs)"],"step_count":2}
{"level":"info","ts":"2026-03-31T18:27:45.081403Z","caller":"traceutil/trace.go:171","msg":"trace[487487156] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"169.344277ms","start":"2026-03-31T18:27:44.912016Z","end":"2026-03-31T18:27:45.08136Z","steps":["trace[487487156] 'process raft request'  (duration: 169.078752ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:27:45.081608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.760776ms","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-03-31T18:27:45.081656Z","caller":"traceutil/trace.go:171","msg":"trace[1000111463] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1171; }","duration":"124.882777ms","start":"2026-03-31T18:27:44.956762Z","end":"2026-03-31T18:27:45.081645Z","steps":["trace[1000111463] 'agreement among raft nodes before linearized reading'  (duration: 124.689923ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:28:31.856508Z","caller":"traceutil/trace.go:171","msg":"trace[1764266833] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"322.225332ms","start":"2026-03-31T18:28:31.534262Z","end":"2026-03-31T18:28:31.856487Z","steps":["trace[1764266833] 'process raft request'  (duration: 322.090489ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:28:31.856668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-31T18:28:31.534234Z","time spent":"322.346775ms","remote":"127.0.0.1:38310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-aab63a9f-bb91-42e6-8d68-0b24ba83d963\" mod_revision:1787 > success:<request_put:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-aab63a9f-bb91-42e6-8d68-0b24ba83d963\" value_size:3632 >> failure:<request_range:<key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-aab63a9f-bb91-42e6-8d68-0b24ba83d963\" > >"}
{"level":"info","ts":"2026-03-31T18:28:31.868486Z","caller":"traceutil/trace.go:171","msg":"trace[49447512] linearizableReadLoop","detail":"{readStateIndex:1904; appliedIndex:1902; }","duration":"197.546544ms","start":"2026-03-31T18:28:31.670907Z","end":"2026-03-31T18:28:31.868454Z","steps":["trace[49447512] 'read index received'  (duration: 185.440739ms)","trace[49447512] 'applied index is now lower than readState.Index'  (duration: 12.104345ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T18:28:31.868682Z","caller":"traceutil/trace.go:171","msg":"trace[947905641] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"201.092386ms","start":"2026-03-31T18:28:31.667562Z","end":"2026-03-31T18:28:31.868654Z","steps":["trace[947905641] 'process raft request'  (duration: 200.79427ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:28:31.869239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.762568ms","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-03-31T18:28:31.869387Z","caller":"traceutil/trace.go:171","msg":"trace[1678627815] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1833; }","duration":"198.517374ms","start":"2026-03-31T18:28:31.670838Z","end":"2026-03-31T18:28:31.869355Z","steps":["trace[1678627815] 'agreement among raft nodes before linearized reading'  (duration: 197.699607ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:29:15.847363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.395957ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15334366701548816241 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2117 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-31T18:29:15.847528Z","caller":"traceutil/trace.go:171","msg":"trace[1467286476] linearizableReadLoop","detail":"{readStateIndex:2207; appliedIndex:2206; }","duration":"147.656816ms","start":"2026-03-31T18:29:15.699848Z","end":"2026-03-31T18:29:15.847505Z","steps":["trace[1467286476] 'read index received'  (duration: 19.020904ms)","trace[1467286476] 'applied index is now lower than readState.Index'  (duration: 128.634122ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T18:29:15.847621Z","caller":"traceutil/trace.go:171","msg":"trace[1357405523] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"172.307114ms","start":"2026-03-31T18:29:15.67526Z","end":"2026-03-31T18:29:15.847567Z","steps":["trace[1357405523] 'process raft request'  (duration: 43.56115ms)","trace[1357405523] 'compare'  (duration: 128.217213ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T18:29:15.847793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.953001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-03-31T18:29:15.847841Z","caller":"traceutil/trace.go:171","msg":"trace[1369091776] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2127; }","duration":"148.043713ms","start":"2026-03-31T18:29:15.699782Z","end":"2026-03-31T18:29:15.847826Z","steps":["trace[1369091776] 'agreement among raft nodes before linearized reading'  (duration: 147.850979ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:29:15.847875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.40938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"}
{"level":"info","ts":"2026-03-31T18:29:15.847953Z","caller":"traceutil/trace.go:171","msg":"trace[830315376] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2127; }","duration":"143.538722ms","start":"2026-03-31T18:29:15.704396Z","end":"2026-03-31T18:29:15.847935Z","steps":["trace[830315376] 'agreement among raft nodes before linearized reading'  (duration: 143.263107ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:29:16.190344Z","caller":"traceutil/trace.go:171","msg":"trace[1377180501] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"149.646367ms","start":"2026-03-31T18:29:16.04066Z","end":"2026-03-31T18:29:16.190306Z","steps":["trace[1377180501] 'process raft request'  (duration: 135.028381ms)","trace[1377180501] 'compare'  (duration: 14.425582ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T18:29:21.775183Z","caller":"traceutil/trace.go:171","msg":"trace[659597646] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"143.575773ms","start":"2026-03-31T18:29:21.631582Z","end":"2026-03-31T18:29:21.775158Z","steps":["trace[659597646] 'process raft request'  (duration: 137.741026ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:29:21.988173Z","caller":"traceutil/trace.go:171","msg":"trace[262036890] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"116.948564ms","start":"2026-03-31T18:29:21.871169Z","end":"2026-03-31T18:29:21.988117Z","steps":["trace[262036890] 'process raft request'  (duration: 92.98361ms)","trace[262036890] 'compare'  (duration: 23.651488ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T18:30:09.414236Z","caller":"traceutil/trace.go:171","msg":"trace[1955675102] transaction","detail":"{read_only:false; response_revision:2560; number_of_response:1; }","duration":"119.082256ms","start":"2026-03-31T18:30:09.295125Z","end":"2026-03-31T18:30:09.414207Z","steps":["trace[1955675102] 'process raft request'  (duration: 119.012045ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:30:09.414301Z","caller":"traceutil/trace.go:171","msg":"trace[880918921] transaction","detail":"{read_only:false; response_revision:2559; number_of_response:1; }","duration":"119.132386ms","start":"2026-03-31T18:30:09.29513Z","end":"2026-03-31T18:30:09.414262Z","steps":["trace[880918921] 'process raft request'  (duration: 32.964447ms)","trace[880918921] 'compare'  (duration: 85.819242ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T18:30:09.612016Z","caller":"traceutil/trace.go:171","msg":"trace[452088264] transaction","detail":"{read_only:false; response_revision:2565; number_of_response:1; }","duration":"108.478574ms","start":"2026-03-31T18:30:09.503499Z","end":"2026-03-31T18:30:09.611978Z","steps":["trace[452088264] 'process raft request'  (duration: 52.089878ms)","trace[452088264] 'compare'  (duration: 56.210871ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T18:30:09.612674Z","caller":"traceutil/trace.go:171","msg":"trace[1530704771] transaction","detail":"{read_only:false; response_revision:2566; number_of_response:1; }","duration":"107.185968ms","start":"2026-03-31T18:30:09.505452Z","end":"2026-03-31T18:30:09.612638Z","steps":["trace[1530704771] 'process raft request'  (duration: 106.840331ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:30:10.297143Z","caller":"traceutil/trace.go:171","msg":"trace[631395935] transaction","detail":"{read_only:false; response_revision:2588; number_of_response:1; }","duration":"117.286349ms","start":"2026-03-31T18:30:10.179814Z","end":"2026-03-31T18:30:10.2971Z","steps":["trace[631395935] 'process raft request'  (duration: 88.215709ms)","trace[631395935] 'compare'  (duration: 28.923837ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T18:30:10.722864Z","caller":"traceutil/trace.go:171","msg":"trace[1593988973] linearizableReadLoop","detail":"{readStateIndex:2691; appliedIndex:2690; }","duration":"194.345545ms","start":"2026-03-31T18:30:10.528481Z","end":"2026-03-31T18:30:10.722827Z","steps":["trace[1593988973] 'read index received'  (duration: 193.671472ms)","trace[1593988973] 'applied index is now lower than readState.Index'  (duration: 672.193µs)"],"step_count":2}
{"level":"info","ts":"2026-03-31T18:30:10.722867Z","caller":"traceutil/trace.go:171","msg":"trace[1692218651] transaction","detail":"{read_only:false; response_revision:2591; number_of_response:1; }","duration":"203.296463ms","start":"2026-03-31T18:30:10.519529Z","end":"2026-03-31T18:30:10.722826Z","steps":["trace[1692218651] 'process raft request'  (duration: 202.728492ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:30:10.723171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.671902ms","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-03-31T18:30:10.723257Z","caller":"traceutil/trace.go:171","msg":"trace[532285175] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2591; }","duration":"194.802184ms","start":"2026-03-31T18:30:10.528437Z","end":"2026-03-31T18:30:10.723239Z","steps":["trace[532285175] 'agreement among raft nodes before linearized reading'  (duration: 194.519598ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:30:10.723428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.899677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-31T18:30:10.72348Z","caller":"traceutil/trace.go:171","msg":"trace[1196454066] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2591; }","duration":"187.991208ms","start":"2026-03-31T18:30:10.535476Z","end":"2026-03-31T18:30:10.723467Z","steps":["trace[1196454066] 'agreement among raft nodes before linearized reading'  (duration: 187.860196ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:30:10.723854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.599715ms","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-03-31T18:30:10.723911Z","caller":"traceutil/trace.go:171","msg":"trace[1111979207] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2591; }","duration":"112.719428ms","start":"2026-03-31T18:30:10.611178Z","end":"2026-03-31T18:30:10.723897Z","steps":["trace[1111979207] 'agreement among raft nodes before linearized reading'  (duration: 112.502854ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:30:46.539254Z","caller":"traceutil/trace.go:171","msg":"trace[821822118] transaction","detail":"{read_only:false; response_revision:2811; number_of_response:1; }","duration":"126.231347ms","start":"2026-03-31T18:30:46.412991Z","end":"2026-03-31T18:30:46.539222Z","steps":["trace[821822118] 'process raft request'  (duration: 126.065264ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:30:46.895041Z","caller":"traceutil/trace.go:171","msg":"trace[1782692197] transaction","detail":"{read_only:false; response_revision:2812; number_of_response:1; }","duration":"286.33923ms","start":"2026-03-31T18:30:46.608671Z","end":"2026-03-31T18:30:46.89501Z","steps":["trace[1782692197] 'process raft request'  (duration: 209.044859ms)","trace[1782692197] 'compare'  (duration: 76.596747ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T18:33:17.851563Z","caller":"traceutil/trace.go:171","msg":"trace[513064664] linearizableReadLoop","detail":"{readStateIndex:3954; appliedIndex:3953; }","duration":"101.1652ms","start":"2026-03-31T18:33:17.750359Z","end":"2026-03-31T18:33:17.851525Z","steps":["trace[513064664] 'read index received'  (duration: 100.922086ms)","trace[513064664] 'applied index is now lower than readState.Index'  (duration: 241.514µs)"],"step_count":2}
{"level":"info","ts":"2026-03-31T18:33:17.851811Z","caller":"traceutil/trace.go:171","msg":"trace[60535862] transaction","detail":"{read_only:false; response_revision:3809; number_of_response:1; }","duration":"133.649812ms","start":"2026-03-31T18:33:17.717978Z","end":"2026-03-31T18:33:17.851628Z","steps":["trace[60535862] 'process raft request'  (duration: 133.314566ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:33:17.851861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.477337ms","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-03-31T18:33:17.851955Z","caller":"traceutil/trace.go:171","msg":"trace[1344332678] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3809; }","duration":"101.632559ms","start":"2026-03-31T18:33:17.750303Z","end":"2026-03-31T18:33:17.851935Z","steps":["trace[1344332678] 'agreement among raft nodes before linearized reading'  (duration: 101.360244ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:34:44.660295Z","caller":"traceutil/trace.go:171","msg":"trace[654598115] transaction","detail":"{read_only:false; response_revision:4992; number_of_response:1; }","duration":"182.978088ms","start":"2026-03-31T18:34:44.477275Z","end":"2026-03-31T18:34:44.660253Z","steps":["trace[654598115] 'process raft request'  (duration: 182.734554ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:35:02.776719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.763585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f41e1c87-7f48-4eb2-9b1d-615331a12f12\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-03-31T18:35:02.77682Z","caller":"traceutil/trace.go:171","msg":"trace[598542081] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f41e1c87-7f48-4eb2-9b1d-615331a12f12; range_end:; response_count:1; response_revision:5374; }","duration":"121.921718ms","start":"2026-03-31T18:35:02.654877Z","end":"2026-03-31T18:35:02.776799Z","steps":["trace[598542081] 'range keys from in-memory index tree'  (duration: 121.574871ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:35:03.005873Z","caller":"traceutil/trace.go:171","msg":"trace[1326796986] linearizableReadLoop","detail":"{readStateIndex:5580; appliedIndex:5579; }","duration":"198.728252ms","start":"2026-03-31T18:35:02.807121Z","end":"2026-03-31T18:35:03.005849Z","steps":["trace[1326796986] 'read index received'  (duration: 198.476897ms)","trace[1326796986] 'applied index is now lower than readState.Index'  (duration: 250.195µs)"],"step_count":2}
{"level":"info","ts":"2026-03-31T18:35:03.005931Z","caller":"traceutil/trace.go:171","msg":"trace[1018141834] transaction","detail":"{read_only:false; response_revision:5375; number_of_response:1; }","duration":"199.480246ms","start":"2026-03-31T18:35:02.806418Z","end":"2026-03-31T18:35:03.005898Z","steps":["trace[1018141834] 'process raft request'  (duration: 199.272272ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:35:03.006188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.961413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"}
{"level":"info","ts":"2026-03-31T18:35:03.006278Z","caller":"traceutil/trace.go:171","msg":"trace[2111253714] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5375; }","duration":"159.101216ms","start":"2026-03-31T18:35:02.847159Z","end":"2026-03-31T18:35:03.00626Z","steps":["trace[2111253714] 'agreement among raft nodes before linearized reading'  (duration: 158.852131ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:35:03.006312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.1425ms","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-03-31T18:35:03.006399Z","caller":"traceutil/trace.go:171","msg":"trace[1360455711] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5375; }","duration":"199.298782ms","start":"2026-03-31T18:35:02.807089Z","end":"2026-03-31T18:35:03.006387Z","steps":["trace[1360455711] 'agreement among raft nodes before linearized reading'  (duration: 198.884144ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:35:03.316686Z","caller":"traceutil/trace.go:171","msg":"trace[1297394914] transaction","detail":"{read_only:false; response_revision:5377; number_of_response:1; }","duration":"227.39871ms","start":"2026-03-31T18:35:03.089245Z","end":"2026-03-31T18:35:03.316644Z","steps":["trace[1297394914] 'process raft request'  (duration: 205.167189ms)","trace[1297394914] 'compare'  (duration: 22.052108ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T18:35:16.038269Z","caller":"traceutil/trace.go:171","msg":"trace[1659477] transaction","detail":"{read_only:false; response_revision:5558; number_of_response:1; }","duration":"100.907961ms","start":"2026-03-31T18:35:15.937318Z","end":"2026-03-31T18:35:16.038226Z","steps":["trace[1659477] 'process raft request'  (duration: 73.948607ms)","trace[1659477] 'compare'  (duration: 26.592837ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T18:35:16.038834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.605344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.109\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-03-31T18:35:16.038936Z","caller":"traceutil/trace.go:171","msg":"trace[838917484] range","detail":"{range_begin:/registry/masterleases/199.204.45.109; range_end:; response_count:1; response_revision:5557; }","duration":"105.750667ms","start":"2026-03-31T18:35:15.933156Z","end":"2026-03-31T18:35:16.038907Z","steps":["trace[838917484] 'range keys from in-memory index tree'  (duration: 104.758598ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:36:12.825333Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2956}
{"level":"info","ts":"2026-03-31T18:36:12.891967Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2956,"took":"65.053503ms","hash":1447412042,"current-db-size-bytes":57810944,"current-db-size":"58 MB","current-db-size-in-use-bytes":33591296,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-03-31T18:36:12.892033Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1447412042,"revision":2956,"compact-revision":-1}
{"level":"info","ts":"2026-03-31T18:41:12.832505Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6043}
{"level":"info","ts":"2026-03-31T18:41:12.931627Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6043,"took":"97.081948ms","hash":3086130208,"current-db-size-bytes":57810944,"current-db-size":"58 MB","current-db-size-in-use-bytes":23265280,"current-db-size-in-use":"23 MB"}
{"level":"info","ts":"2026-03-31T18:41:12.931953Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3086130208,"revision":6043,"compact-revision":2956}
{"level":"info","ts":"2026-03-31T18:41:15.549121Z","caller":"traceutil/trace.go:171","msg":"trace[1451202971] linearizableReadLoop","detail":"{readStateIndex:8552; appliedIndex:8551; }","duration":"232.846854ms","start":"2026-03-31T18:41:15.316256Z","end":"2026-03-31T18:41:15.549103Z","steps":["trace[1451202971] 'read index received'  (duration: 232.688631ms)","trace[1451202971] 'applied index is now lower than readState.Index'  (duration: 157.713µs)"],"step_count":2}
{"level":"info","ts":"2026-03-31T18:41:15.54922Z","caller":"traceutil/trace.go:171","msg":"trace[1144123901] transaction","detail":"{read_only:false; response_revision:8255; number_of_response:1; }","duration":"295.62352ms","start":"2026-03-31T18:41:15.253576Z","end":"2026-03-31T18:41:15.549199Z","steps":["trace[1144123901] 'process raft request'  (duration: 295.394246ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:41:15.54929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.021488ms","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-03-31T18:41:15.549313Z","caller":"traceutil/trace.go:171","msg":"trace[2031710661] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8255; }","duration":"233.062788ms","start":"2026-03-31T18:41:15.316245Z","end":"2026-03-31T18:41:15.549308Z","steps":["trace[2031710661] 'agreement among raft nodes before linearized reading'  (duration: 232.946756ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:41:15.549423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.991083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-31T18:41:15.549466Z","caller":"traceutil/trace.go:171","msg":"trace[387594500] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:8255; }","duration":"191.073715ms","start":"2026-03-31T18:41:15.358378Z","end":"2026-03-31T18:41:15.549452Z","steps":["trace[387594500] 'agreement among raft nodes before linearized reading'  (duration: 191.009984ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:41:15.549593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.273421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-31T18:41:15.549616Z","caller":"traceutil/trace.go:171","msg":"trace[263346622] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:8255; }","duration":"179.336382ms","start":"2026-03-31T18:41:15.370273Z","end":"2026-03-31T18:41:15.54961Z","steps":["trace[263346622] 'agreement among raft nodes before linearized reading'  (duration: 179.301392ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:41:15.705123Z","caller":"traceutil/trace.go:171","msg":"trace[1665838200] transaction","detail":"{read_only:false; response_revision:8258; number_of_response:1; }","duration":"147.209912ms","start":"2026-03-31T18:41:15.557888Z","end":"2026-03-31T18:41:15.705098Z","steps":["trace[1665838200] 'process raft request'  (duration: 147.153811ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:41:15.7052Z","caller":"traceutil/trace.go:171","msg":"trace[443115144] transaction","detail":"{read_only:false; response_revision:8257; number_of_response:1; }","duration":"151.0444ms","start":"2026-03-31T18:41:15.554111Z","end":"2026-03-31T18:41:15.705155Z","steps":["trace[443115144] 'process raft request'  (duration: 126.085614ms)","trace[443115144] 'compare'  (duration: 24.733151ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T18:41:28.228192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.944099ms","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-03-31T18:41:28.22833Z","caller":"traceutil/trace.go:171","msg":"trace[1319423875] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8324; }","duration":"139.182764ms","start":"2026-03-31T18:41:28.089122Z","end":"2026-03-31T18:41:28.228305Z","steps":["trace[1319423875] 'count revisions from in-memory index tree'  (duration: 138.796336ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:41:28.228715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.169728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-31T18:41:28.229714Z","caller":"traceutil/trace.go:171","msg":"trace[1758861940] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:8324; }","duration":"112.31313ms","start":"2026-03-31T18:41:28.11647Z","end":"2026-03-31T18:41:28.228783Z","steps":["trace[1758861940] 'count revisions from in-memory index tree'  (duration: 112.055896ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:41:28.540805Z","caller":"traceutil/trace.go:171","msg":"trace[1625084719] linearizableReadLoop","detail":"{readStateIndex:8625; appliedIndex:8624; }","duration":"105.810961ms","start":"2026-03-31T18:41:28.434967Z","end":"2026-03-31T18:41:28.540778Z","steps":["trace[1625084719] 'read index received'  (duration: 105.613527ms)","trace[1625084719] 'applied index is now lower than readState.Index'  (duration: 196.054µs)"],"step_count":2}
{"level":"info","ts":"2026-03-31T18:41:28.540905Z","caller":"traceutil/trace.go:171","msg":"trace[1259247910] transaction","detail":"{read_only:false; response_revision:8325; number_of_response:1; }","duration":"149.453328ms","start":"2026-03-31T18:41:28.391418Z","end":"2026-03-31T18:41:28.540871Z","steps":["trace[1259247910] 'process raft request'  (duration: 149.180553ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:41:28.541115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.093227ms","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-03-31T18:41:28.541161Z","caller":"traceutil/trace.go:171","msg":"trace[1486549332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8325; }","duration":"106.210349ms","start":"2026-03-31T18:41:28.43494Z","end":"2026-03-31T18:41:28.54115Z","steps":["trace[1486549332] 'agreement among raft nodes before linearized reading'  (duration: 105.992945ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:41:28.541373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.617078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-03-31T18:41:28.541469Z","caller":"traceutil/trace.go:171","msg":"trace[45205829] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8325; }","duration":"101.768611ms","start":"2026-03-31T18:41:28.439676Z","end":"2026-03-31T18:41:28.541444Z","steps":["trace[45205829] 'agreement among raft nodes before linearized reading'  (duration: 101.488256ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:41:56.820558Z","caller":"traceutil/trace.go:171","msg":"trace[532477605] linearizableReadLoop","detail":"{readStateIndex:8839; appliedIndex:8838; }","duration":"158.632376ms","start":"2026-03-31T18:41:56.661903Z","end":"2026-03-31T18:41:56.820535Z","steps":["trace[532477605] 'read index received'  (duration: 152.296741ms)","trace[532477605] 'applied index is now lower than readState.Index'  (duration: 6.334535ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T18:41:56.820964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.045264ms","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-03-31T18:41:56.820968Z","caller":"traceutil/trace.go:171","msg":"trace[1211197471] transaction","detail":"{read_only:false; response_revision:8531; number_of_response:1; }","duration":"192.958964ms","start":"2026-03-31T18:41:56.627956Z","end":"2026-03-31T18:41:56.820915Z","steps":["trace[1211197471] 'process raft request'  (duration: 186.349234ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:41:56.821012Z","caller":"traceutil/trace.go:171","msg":"trace[1290381349] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8531; }","duration":"159.142046ms","start":"2026-03-31T18:41:56.661857Z","end":"2026-03-31T18:41:56.820999Z","steps":["trace[1290381349] 'agreement among raft nodes before linearized reading'  (duration: 158.989103ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:41:56.821043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.103648ms","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-03-31T18:41:56.821137Z","caller":"traceutil/trace.go:171","msg":"trace[1194107713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8531; }","duration":"148.22166ms","start":"2026-03-31T18:41:56.672898Z","end":"2026-03-31T18:41:56.821119Z","steps":["trace[1194107713] 'agreement among raft nodes before linearized reading'  (duration: 147.953675ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:42:08.641346Z","caller":"traceutil/trace.go:171","msg":"trace[1654570031] linearizableReadLoop","detail":"{readStateIndex:8944; appliedIndex:8943; }","duration":"122.848568ms","start":"2026-03-31T18:42:08.518475Z","end":"2026-03-31T18:42:08.641324Z","steps":["trace[1654570031] 'read index received'  (duration: 118.441331ms)","trace[1654570031] 'applied index is now lower than readState.Index'  (duration: 4.406077ms)"],"step_count":2}
{"level":"info","ts":"2026-03-31T18:42:08.641433Z","caller":"traceutil/trace.go:171","msg":"trace[881439930] transaction","detail":"{read_only:false; response_revision:8632; number_of_response:1; }","duration":"124.95897ms","start":"2026-03-31T18:42:08.516439Z","end":"2026-03-31T18:42:08.641398Z","steps":["trace[881439930] 'process raft request'  (duration: 120.567242ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-31T18:42:08.641519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.017632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-m4fcq\" ","response":"range_response_count:1 size:2800"}
{"level":"info","ts":"2026-03-31T18:42:08.641567Z","caller":"traceutil/trace.go:171","msg":"trace[433522652] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-m4fcq; range_end:; response_count:1; response_revision:8632; }","duration":"123.094633ms","start":"2026-03-31T18:42:08.518461Z","end":"2026-03-31T18:42:08.641556Z","steps":["trace[433522652] 'agreement among raft nodes before linearized reading'  (duration: 122.94129ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:42:09.29441Z","caller":"traceutil/trace.go:171","msg":"trace[1846303621] transaction","detail":"{read_only:false; response_revision:8639; number_of_response:1; }","duration":"138.658171ms","start":"2026-03-31T18:42:09.155679Z","end":"2026-03-31T18:42:09.294337Z","steps":["trace[1846303621] 'process raft request'  (duration: 134.009548ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:42:09.430458Z","caller":"traceutil/trace.go:171","msg":"trace[1363220733] linearizableReadLoop","detail":"{readStateIndex:8952; appliedIndex:8951; }","duration":"122.789277ms","start":"2026-03-31T18:42:09.307607Z","end":"2026-03-31T18:42:09.430396Z","steps":["trace[1363220733] 'read index received'  (duration: 113.146837ms)","trace[1363220733] 'applied index is now lower than readState.Index'  (duration: 9.63969ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-31T18:42:09.430978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.342589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"}
{"level":"info","ts":"2026-03-31T18:42:09.430975Z","caller":"traceutil/trace.go:171","msg":"trace[1867372258] transaction","detail":"{read_only:false; response_revision:8640; number_of_response:1; }","duration":"130.708964ms","start":"2026-03-31T18:42:09.300241Z","end":"2026-03-31T18:42:09.43095Z","steps":["trace[1867372258] 'process raft request'  (duration: 120.609194ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:42:09.431038Z","caller":"traceutil/trace.go:171","msg":"trace[239753576] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8640; }","duration":"123.464361ms","start":"2026-03-31T18:42:09.307561Z","end":"2026-03-31T18:42:09.431026Z","steps":["trace[239753576] 'agreement among raft nodes before linearized reading'  (duration: 123.005951ms)"],"step_count":1}
{"level":"info","ts":"2026-03-31T18:42:56.953385Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024ac.wal"}
{"level":"info","ts":"2026-03-31T18:44:00.433887Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d71a1778b31d4ce","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-03-31T18:44:00.439035Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-03-31T18:44:00.439145Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-03-31T18:46:12.839209Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8242}
{"level":"info","ts":"2026-03-31T18:46:12.911187Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8242,"took":"69.98096ms","hash":2228636173,"current-db-size-bytes":57810944,"current-db-size":"58 MB","current-db-size-in-use-bytes":25485312,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-03-31T18:46:12.911268Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2228636173,"revision":8242,"compact-revision":6043}
{"level":"info","ts":"2026-03-31T18:51:12.844818Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10645}
{"level":"info","ts":"2026-03-31T18:51:12.928019Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10645,"took":"81.545584ms","hash":2201400200,"current-db-size-bytes":57810944,"current-db-size":"58 MB","current-db-size-in-use-bytes":20623360,"current-db-size-in-use":"21 MB"}
{"level":"info","ts":"2026-03-31T18:51:12.928093Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2201400200,"revision":10645,"compact-revision":8242}