{"level":"warn","ts":"2026-04-14T09:52:06.208417Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-14T09:52:06.208512Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.81:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.81:2380","--initial-cluster=instance=https://199.19.213.81:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.81:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.81: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-04-14T09:52:06.208577Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-14T09:52:06.208592Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.81:2380"]}
{"level":"info","ts":"2026-04-14T09:52:06.208609Z","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-04-14T09:52:06.20922Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.81:2379"]}
{"level":"info","ts":"2026-04-14T09:52:06.209289Z","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":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.81:2380"],"listen-peer-urls":["https://199.19.213.81:2380"],"advertise-client-urls":["https://199.19.213.81:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.81:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.81: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-04-14T09:52:06.213227Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.68136ms"}
{"level":"info","ts":"2026-04-14T09:52:06.225971Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1627b0b72e417489","cluster-id":"d42e5eae8a1b814c"}
{"level":"info","ts":"2026-04-14T09:52:06.226057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 switched to configuration voters=()"}
{"level":"info","ts":"2026-04-14T09:52:06.226076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became follower at term 0"}
{"level":"info","ts":"2026-04-14T09:52:06.226087Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1627b0b72e417489 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-14T09:52:06.226095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became follower at term 1"}
{"level":"info","ts":"2026-04-14T09:52:06.226126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 switched to configuration voters=(1596438893727675529)"}
{"level":"warn","ts":"2026-04-14T09:52:06.234635Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-14T09:52:06.236031Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-14T09:52:06.237038Z","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-04-14T09:52:06.239723Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1627b0b72e417489","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-14T09:52:06.24Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1627b0b72e417489","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-14T09:52:06.240033Z","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-04-14T09:52:06.240126Z","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-04-14T09:52:06.240141Z","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-04-14T09:52:06.24198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 switched to configuration voters=(1596438893727675529)"}
{"level":"info","ts":"2026-04-14T09:52:06.242548Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d42e5eae8a1b814c","local-member-id":"1627b0b72e417489","added-peer-id":"1627b0b72e417489","added-peer-peer-urls":["https://199.19.213.81:2380"]}
{"level":"info","ts":"2026-04-14T09:52:06.243682Z","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-04-14T09:52:06.243734Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.81:2380"}
{"level":"info","ts":"2026-04-14T09:52:06.243751Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.81:2380"}
{"level":"info","ts":"2026-04-14T09:52:06.244475Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1627b0b72e417489","initial-advertise-peer-urls":["https://199.19.213.81:2380"],"listen-peer-urls":["https://199.19.213.81:2380"],"advertise-client-urls":["https://199.19.213.81:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.81:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-14T09:52:06.244511Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-14T09:52:07.226247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 is starting a new election at term 1"}
{"level":"info","ts":"2026-04-14T09:52:07.226333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-14T09:52:07.226361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 received MsgPreVoteResp from 1627b0b72e417489 at term 1"}
{"level":"info","ts":"2026-04-14T09:52:07.226381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became candidate at term 2"}
{"level":"info","ts":"2026-04-14T09:52:07.226393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 received MsgVoteResp from 1627b0b72e417489 at term 2"}
{"level":"info","ts":"2026-04-14T09:52:07.226413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1627b0b72e417489 became leader at term 2"}
{"level":"info","ts":"2026-04-14T09:52:07.226427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1627b0b72e417489 elected leader 1627b0b72e417489 at term 2"}
{"level":"info","ts":"2026-04-14T09:52:07.227303Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-14T09:52:07.22819Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-14T09:52:07.22819Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1627b0b72e417489","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.81:2379]}","request-path":"/0/members/1627b0b72e417489/attributes","cluster-id":"d42e5eae8a1b814c","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-14T09:52:07.228282Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-14T09:52:07.228345Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d42e5eae8a1b814c","local-member-id":"1627b0b72e417489","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-14T09:52:07.228458Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-14T09:52:07.228489Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-14T09:52:07.228586Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-14T09:52:07.228607Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-14T09:52:07.231799Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.81:2379"}
{"level":"info","ts":"2026-04-14T09:52:07.233085Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-14T09:52:24.856924Z","caller":"traceutil/trace.go:171","msg":"trace[573775600] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"208.03778ms","start":"2026-04-14T09:52:24.648851Z","end":"2026-04-14T09:52:24.856888Z","steps":["trace[573775600] 'process raft request'  (duration: 207.829095ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:52:36.026398Z","caller":"traceutil/trace.go:171","msg":"trace[1147227566] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"126.482726ms","start":"2026-04-14T09:52:35.899885Z","end":"2026-04-14T09:52:36.026368Z","steps":["trace[1147227566] 'process raft request'  (duration: 119.434179ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:52:36.029591Z","caller":"traceutil/trace.go:171","msg":"trace[1422000233] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"127.744654ms","start":"2026-04-14T09:52:35.90182Z","end":"2026-04-14T09:52:36.029565Z","steps":["trace[1422000233] 'process raft request'  (duration: 124.471421ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:52:36.029776Z","caller":"traceutil/trace.go:171","msg":"trace[745710956] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"125.395713ms","start":"2026-04-14T09:52:35.904373Z","end":"2026-04-14T09:52:36.029768Z","steps":["trace[745710956] 'process raft request'  (duration: 125.021324ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:52:36.029831Z","caller":"traceutil/trace.go:171","msg":"trace[819842967] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"115.704426ms","start":"2026-04-14T09:52:35.914119Z","end":"2026-04-14T09:52:36.029823Z","steps":["trace[819842967] 'process raft request'  (duration: 115.515781ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:52:36.029947Z","caller":"traceutil/trace.go:171","msg":"trace[445871852] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"111.427042ms","start":"2026-04-14T09:52:35.918514Z","end":"2026-04-14T09:52:36.029941Z","steps":["trace[445871852] 'process raft request'  (duration: 111.229507ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:52:36.269051Z","caller":"traceutil/trace.go:171","msg":"trace[1392160675] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"113.494078ms","start":"2026-04-14T09:52:36.155529Z","end":"2026-04-14T09:52:36.269023Z","steps":["trace[1392160675] 'process raft request'  (duration: 106.879151ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:52:42.215072Z","caller":"traceutil/trace.go:171","msg":"trace[1606715854] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"116.673355ms","start":"2026-04-14T09:52:42.098365Z","end":"2026-04-14T09:52:42.215038Z","steps":["trace[1606715854] 'process raft request'  (duration: 115.726014ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:52:42.434496Z","caller":"traceutil/trace.go:171","msg":"trace[210530766] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"194.942945ms","start":"2026-04-14T09:52:42.239522Z","end":"2026-04-14T09:52:42.434465Z","steps":["trace[210530766] 'process raft request'  (duration: 185.808631ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:52:42.529358Z","caller":"traceutil/trace.go:171","msg":"trace[2107212911] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"260.823466ms","start":"2026-04-14T09:52:42.268506Z","end":"2026-04-14T09:52:42.52933Z","steps":["trace[2107212911] 'process raft request'  (duration: 260.671642ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:52:43.028851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.883516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-14T09:52:43.028967Z","caller":"traceutil/trace.go:171","msg":"trace[1506929525] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:618; }","duration":"487.050179ms","start":"2026-04-14T09:52:42.541896Z","end":"2026-04-14T09:52:43.028946Z","steps":["trace[1506929525] 'range keys from in-memory index tree'  (duration: 486.790704ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:52:43.029008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T09:52:42.541881Z","time spent":"487.11622ms","remote":"127.0.0.1:43924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "}
{"level":"warn","ts":"2026-04-14T09:52:43.029914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.594517ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8397416202275804944 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:466 > 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:16"}
{"level":"info","ts":"2026-04-14T09:52:43.030096Z","caller":"traceutil/trace.go:171","msg":"trace[518434211] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"451.7398ms","start":"2026-04-14T09:52:42.578335Z","end":"2026-04-14T09:52:43.030075Z","steps":["trace[518434211] 'process raft request'  (duration: 312.410247ms)","trace[518434211] 'compare'  (duration: 138.453003ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-14T09:52:43.030159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T09:52:42.578318Z","time spent":"451.808321ms","remote":"127.0.0.1:43950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:466 > 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-04-14T09:52:43.03046Z","caller":"traceutil/trace.go:171","msg":"trace[511024944] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"212.125358ms","start":"2026-04-14T09:52:42.818323Z","end":"2026-04-14T09:52:43.030448Z","steps":["trace[511024944] 'process raft request'  (duration: 212.019806ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:52:44.490619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.799632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-14T09:52:44.490741Z","caller":"traceutil/trace.go:171","msg":"trace[546884738] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:644; }","duration":"120.997355ms","start":"2026-04-14T09:52:44.369723Z","end":"2026-04-14T09:52:44.49072Z","steps":["trace[546884738] 'range keys from in-memory index tree'  (duration: 120.72923ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:53:25.427915Z","caller":"traceutil/trace.go:171","msg":"trace[1881444562] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"109.772415ms","start":"2026-04-14T09:53:25.318076Z","end":"2026-04-14T09:53:25.427849Z","steps":["trace[1881444562] 'process raft request'  (duration: 109.59269ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:53:25.561524Z","caller":"traceutil/trace.go:171","msg":"trace[709243983] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"129.011257ms","start":"2026-04-14T09:53:25.432485Z","end":"2026-04-14T09:53:25.561496Z","steps":["trace[709243983] 'process raft request'  (duration: 128.806762ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:53:49.791754Z","caller":"traceutil/trace.go:171","msg":"trace[821317075] linearizableReadLoop","detail":"{readStateIndex:1485; appliedIndex:1484; }","duration":"116.916561ms","start":"2026-04-14T09:53:49.674808Z","end":"2026-04-14T09:53:49.791725Z","steps":["trace[821317075] 'read index received'  (duration: 116.626515ms)","trace[821317075] 'applied index is now lower than readState.Index'  (duration: 288.346µs)"],"step_count":2}
{"level":"info","ts":"2026-04-14T09:53:49.792162Z","caller":"traceutil/trace.go:171","msg":"trace[432875694] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"142.728221ms","start":"2026-04-14T09:53:49.649415Z","end":"2026-04-14T09:53:49.792143Z","steps":["trace[432875694] 'process raft request'  (duration: 142.121158ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:53:49.792395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.649643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-04-14T09:53:49.792415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.582237ms","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-04-14T09:53:49.792483Z","caller":"traceutil/trace.go:171","msg":"trace[63115610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1441; }","duration":"115.764956ms","start":"2026-04-14T09:53:49.676694Z","end":"2026-04-14T09:53:49.792458Z","steps":["trace[63115610] 'agreement among raft nodes before linearized reading'  (duration: 115.53069ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:53:49.792489Z","caller":"traceutil/trace.go:171","msg":"trace[1349341642] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1441; }","duration":"117.70061ms","start":"2026-04-14T09:53:49.674767Z","end":"2026-04-14T09:53:49.792467Z","steps":["trace[1349341642] 'agreement among raft nodes before linearized reading'  (duration: 117.509245ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:54:15.37832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.48794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"warn","ts":"2026-04-14T09:54:15.37831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.481918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-14T09:54:15.378411Z","caller":"traceutil/trace.go:171","msg":"trace[1066795544] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1860; }","duration":"351.651634ms","start":"2026-04-14T09:54:15.02674Z","end":"2026-04-14T09:54:15.378392Z","steps":["trace[1066795544] 'range keys from in-memory index tree'  (duration: 351.269485ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:54:15.378449Z","caller":"traceutil/trace.go:171","msg":"trace[1625785730] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1860; }","duration":"358.668632ms","start":"2026-04-14T09:54:15.019739Z","end":"2026-04-14T09:54:15.378407Z","steps":["trace[1625785730] 'range keys from in-memory index tree'  (duration: 358.239313ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:54:15.378917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T09:54:15.019696Z","time spent":"359.199494ms","remote":"127.0.0.1:43950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-14T09:54:15.378478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T09:54:15.026713Z","time spent":"351.746636ms","remote":"127.0.0.1:44626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-04-14T09:54:15.378344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.684533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a0996a7-ffd8-48cf-9400-843ce0b8209a\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-04-14T09:54:15.379231Z","caller":"traceutil/trace.go:171","msg":"trace[2140157626] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2a0996a7-ffd8-48cf-9400-843ce0b8209a; range_end:; response_count:1; response_revision:1860; }","duration":"367.553443ms","start":"2026-04-14T09:54:15.011625Z","end":"2026-04-14T09:54:15.379178Z","steps":["trace[2140157626] 'range keys from in-memory index tree'  (duration: 366.458898ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:54:15.380374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T09:54:15.011548Z","time spent":"367.833729ms","remote":"127.0.0.1:43862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2a0996a7-ffd8-48cf-9400-843ce0b8209a\" "}
{"level":"info","ts":"2026-04-14T09:54:15.406547Z","caller":"traceutil/trace.go:171","msg":"trace[1411108507] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"278.209529ms","start":"2026-04-14T09:54:15.128284Z","end":"2026-04-14T09:54:15.406494Z","steps":["trace[1411108507] 'process raft request'  (duration: 278.013655ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:54:15.416364Z","caller":"traceutil/trace.go:171","msg":"trace[1154754910] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"201.916479ms","start":"2026-04-14T09:54:15.214425Z","end":"2026-04-14T09:54:15.416341Z","steps":["trace[1154754910] 'process raft request'  (duration: 201.783016ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:54:15.841796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.257748ms","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-04-14T09:54:15.841879Z","caller":"traceutil/trace.go:171","msg":"trace[1815333548] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1864; }","duration":"127.38394ms","start":"2026-04-14T09:54:15.714476Z","end":"2026-04-14T09:54:15.84186Z","steps":["trace[1815333548] 'range keys from in-memory index tree'  (duration: 127.071225ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:54:15.841966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.182203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a630857f2f58f5\" ","response":"range_response_count:1 size:982"}
{"level":"info","ts":"2026-04-14T09:54:15.842167Z","caller":"traceutil/trace.go:171","msg":"trace[370890150] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a630857f2f58f5; range_end:; response_count:1; response_revision:1864; }","duration":"169.415517ms","start":"2026-04-14T09:54:15.672737Z","end":"2026-04-14T09:54:15.842153Z","steps":["trace[370890150] 'range keys from in-memory index tree'  (duration: 168.64644ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:54:30.240584Z","caller":"traceutil/trace.go:171","msg":"trace[1822838421] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"154.611396ms","start":"2026-04-14T09:54:30.085942Z","end":"2026-04-14T09:54:30.240553Z","steps":["trace[1822838421] 'process raft request'  (duration: 154.390141ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:54:30.241328Z","caller":"traceutil/trace.go:171","msg":"trace[1147452439] linearizableReadLoop","detail":"{readStateIndex:2066; appliedIndex:2066; }","duration":"154.710619ms","start":"2026-04-14T09:54:30.086604Z","end":"2026-04-14T09:54:30.241315Z","steps":["trace[1147452439] 'read index received'  (duration: 154.705538ms)","trace[1147452439] 'applied index is now lower than readState.Index'  (duration: 4.07µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-14T09:54:30.241507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.874941ms","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-04-14T09:54:30.24155Z","caller":"traceutil/trace.go:171","msg":"trace[342115581] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1990; }","duration":"154.948483ms","start":"2026-04-14T09:54:30.086592Z","end":"2026-04-14T09:54:30.24154Z","steps":["trace[342115581] 'agreement among raft nodes before linearized reading'  (duration: 154.793069ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:54:30.241741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.251782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-04-14T09:54:30.241775Z","caller":"traceutil/trace.go:171","msg":"trace[1242687405] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1990; }","duration":"152.318634ms","start":"2026-04-14T09:54:30.089449Z","end":"2026-04-14T09:54:30.241768Z","steps":["trace[1242687405] 'agreement among raft nodes before linearized reading'  (duration: 152.231232ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:54:51.728497Z","caller":"traceutil/trace.go:171","msg":"trace[1690184626] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"190.651732ms","start":"2026-04-14T09:54:51.537805Z","end":"2026-04-14T09:54:51.728457Z","steps":["trace[1690184626] 'process raft request'  (duration: 190.423287ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:54:51.773249Z","caller":"traceutil/trace.go:171","msg":"trace[148522968] linearizableReadLoop","detail":"{readStateIndex:2192; appliedIndex:2190; }","duration":"209.524517ms","start":"2026-04-14T09:54:51.563705Z","end":"2026-04-14T09:54:51.773229Z","steps":["trace[148522968] 'read index received'  (duration: 164.609684ms)","trace[148522968] 'applied index is now lower than readState.Index'  (duration: 44.913843ms)"],"step_count":2}
{"level":"info","ts":"2026-04-14T09:54:51.773362Z","caller":"traceutil/trace.go:171","msg":"trace[2095103823] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"231.887482ms","start":"2026-04-14T09:54:51.541463Z","end":"2026-04-14T09:54:51.773351Z","steps":["trace[2095103823] 'process raft request'  (duration: 196.31763ms)","trace[2095103823] 'compare'  (duration: 35.357797ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-14T09:54:51.773593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.879297ms","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-04-14T09:54:51.773624Z","caller":"traceutil/trace.go:171","msg":"trace[949466990] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2111; }","duration":"209.952328ms","start":"2026-04-14T09:54:51.563662Z","end":"2026-04-14T09:54:51.773614Z","steps":["trace[949466990] 'agreement among raft nodes before linearized reading'  (duration: 209.822284ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:54:51.774162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.168501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-04-14T09:54:51.774257Z","caller":"traceutil/trace.go:171","msg":"trace[978026994] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2111; }","duration":"143.323354ms","start":"2026-04-14T09:54:51.630908Z","end":"2026-04-14T09:54:51.774232Z","steps":["trace[978026994] 'agreement among raft nodes before linearized reading'  (duration: 142.653529ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:54:52.529668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.147744ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8397416202275807972 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2104 > 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-04-14T09:54:52.530338Z","caller":"traceutil/trace.go:171","msg":"trace[145117296] linearizableReadLoop","detail":"{readStateIndex:2195; appliedIndex:2194; }","duration":"187.756086ms","start":"2026-04-14T09:54:52.342561Z","end":"2026-04-14T09:54:52.530317Z","steps":["trace[145117296] 'read index received'  (duration: 68.941µs)","trace[145117296] 'applied index is now lower than readState.Index'  (duration: 187.684965ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-14T09:54:52.530634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.078233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-04-14T09:54:52.530737Z","caller":"traceutil/trace.go:171","msg":"trace[173271646] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2114; }","duration":"188.245978ms","start":"2026-04-14T09:54:52.34248Z","end":"2026-04-14T09:54:52.530726Z","steps":["trace[173271646] 'agreement among raft nodes before linearized reading'  (duration: 188.014312ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:54:52.530999Z","caller":"traceutil/trace.go:171","msg":"trace[2115692724] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"449.172715ms","start":"2026-04-14T09:54:52.081783Z","end":"2026-04-14T09:54:52.530956Z","steps":["trace[2115692724] 'process raft request'  (duration: 142.637889ms)","trace[2115692724] 'compare'  (duration: 304.703985ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-14T09:54:52.531168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T09:54:52.081763Z","time spent":"449.309698ms","remote":"127.0.0.1:43950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2104 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-04-14T09:54:52.531883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.649214ms","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-04-14T09:54:52.531964Z","caller":"traceutil/trace.go:171","msg":"trace[340712244] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2115; }","duration":"187.783787ms","start":"2026-04-14T09:54:52.344158Z","end":"2026-04-14T09:54:52.531942Z","steps":["trace[340712244] 'agreement among raft nodes before linearized reading'  (duration: 187.558452ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:54:52.532778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.371721ms","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-04-14T09:54:52.533034Z","caller":"traceutil/trace.go:171","msg":"trace[369139316] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2115; }","duration":"188.547254ms","start":"2026-04-14T09:54:52.344333Z","end":"2026-04-14T09:54:52.53288Z","steps":["trace[369139316] 'agreement among raft nodes before linearized reading'  (duration: 187.437889ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:54:52.776838Z","caller":"traceutil/trace.go:171","msg":"trace[1142170137] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"241.004737ms","start":"2026-04-14T09:54:52.535815Z","end":"2026-04-14T09:54:52.77682Z","steps":["trace[1142170137] 'process raft request'  (duration: 240.887285ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:54:52.777033Z","caller":"traceutil/trace.go:171","msg":"trace[16604269] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"241.916289ms","start":"2026-04-14T09:54:52.535105Z","end":"2026-04-14T09:54:52.777021Z","steps":["trace[16604269] 'process raft request'  (duration: 230.148583ms)","trace[16604269] 'compare'  (duration: 10.959937ms)"],"step_count":2}
{"level":"info","ts":"2026-04-14T09:54:52.777003Z","caller":"traceutil/trace.go:171","msg":"trace[978833217] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"163.08333ms","start":"2026-04-14T09:54:52.613892Z","end":"2026-04-14T09:54:52.776975Z","steps":["trace[978833217] 'process raft request'  (duration: 162.995708ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:54:52.777076Z","caller":"traceutil/trace.go:171","msg":"trace[863223607] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"239.083664ms","start":"2026-04-14T09:54:52.537982Z","end":"2026-04-14T09:54:52.777066Z","steps":["trace[863223607] 'process raft request'  (duration: 238.799457ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:55:45.128073Z","caller":"traceutil/trace.go:171","msg":"trace[523636310] linearizableReadLoop","detail":"{readStateIndex:2595; appliedIndex:2594; }","duration":"167.938512ms","start":"2026-04-14T09:55:44.960113Z","end":"2026-04-14T09:55:45.128051Z","steps":["trace[523636310] 'read index received'  (duration: 167.780239ms)","trace[523636310] 'applied index is now lower than readState.Index'  (duration: 157.463µs)"],"step_count":2}
{"level":"info","ts":"2026-04-14T09:55:45.128193Z","caller":"traceutil/trace.go:171","msg":"trace[1288041860] transaction","detail":"{read_only:false; response_revision:2502; number_of_response:1; }","duration":"168.449055ms","start":"2026-04-14T09:55:44.959705Z","end":"2026-04-14T09:55:45.128154Z","steps":["trace[1288041860] 'process raft request'  (duration: 168.220369ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:55:45.128281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.152847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-14T09:55:45.128338Z","caller":"traceutil/trace.go:171","msg":"trace[146560292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2502; }","duration":"168.24522ms","start":"2026-04-14T09:55:44.960079Z","end":"2026-04-14T09:55:45.128325Z","steps":["trace[146560292] 'agreement among raft nodes before linearized reading'  (duration: 168.090196ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:55:45.128342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.352973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-04-14T09:55:45.128393Z","caller":"traceutil/trace.go:171","msg":"trace[1247548127] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2502; }","duration":"114.390484ms","start":"2026-04-14T09:55:45.013978Z","end":"2026-04-14T09:55:45.128368Z","steps":["trace[1247548127] 'agreement among raft nodes before linearized reading'  (duration: 114.254861ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:55:45.128416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.017537ms","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-04-14T09:55:45.128454Z","caller":"traceutil/trace.go:171","msg":"trace[974360319] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2502; }","duration":"115.080269ms","start":"2026-04-14T09:55:45.013362Z","end":"2026-04-14T09:55:45.128443Z","steps":["trace[974360319] 'agreement among raft nodes before linearized reading'  (duration: 114.994528ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:55:45.12833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.571947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-04-14T09:55:45.128515Z","caller":"traceutil/trace.go:171","msg":"trace[68102981] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2502; }","duration":"137.794672ms","start":"2026-04-14T09:55:44.990714Z","end":"2026-04-14T09:55:45.128508Z","steps":["trace[68102981] 'agreement among raft nodes before linearized reading'  (duration: 137.464635ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:56:18.011162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.611766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"}
{"level":"info","ts":"2026-04-14T09:56:18.011277Z","caller":"traceutil/trace.go:171","msg":"trace[111938929] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2685; }","duration":"147.80543ms","start":"2026-04-14T09:56:17.863447Z","end":"2026-04-14T09:56:18.011253Z","steps":["trace[111938929] 'range keys from in-memory index tree'  (duration: 147.350259ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:56:18.210457Z","caller":"traceutil/trace.go:171","msg":"trace[1961782360] linearizableReadLoop","detail":"{readStateIndex:2786; appliedIndex:2785; }","duration":"167.424443ms","start":"2026-04-14T09:56:18.043005Z","end":"2026-04-14T09:56:18.210429Z","steps":["trace[1961782360] 'read index received'  (duration: 167.32611ms)","trace[1961782360] 'applied index is now lower than readState.Index'  (duration: 97.193µs)"],"step_count":2}
{"level":"info","ts":"2026-04-14T09:56:18.210542Z","caller":"traceutil/trace.go:171","msg":"trace[1288758380] transaction","detail":"{read_only:false; response_revision:2686; number_of_response:1; }","duration":"191.367263ms","start":"2026-04-14T09:56:18.019144Z","end":"2026-04-14T09:56:18.210511Z","steps":["trace[1288758380] 'process raft request'  (duration: 191.097587ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:56:18.21063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.596997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-14T09:56:18.210715Z","caller":"traceutil/trace.go:171","msg":"trace[1789377065] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:2686; }","duration":"167.74881ms","start":"2026-04-14T09:56:18.042949Z","end":"2026-04-14T09:56:18.210698Z","steps":["trace[1789377065] 'agreement among raft nodes before linearized reading'  (duration: 167.579246ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:56:18.389882Z","caller":"traceutil/trace.go:171","msg":"trace[233321940] linearizableReadLoop","detail":"{readStateIndex:2787; appliedIndex:2786; }","duration":"179.29267ms","start":"2026-04-14T09:56:18.210561Z","end":"2026-04-14T09:56:18.389854Z","steps":["trace[233321940] 'read index received'  (duration: 167.962565ms)","trace[233321940] 'applied index is now lower than readState.Index'  (duration: 11.328705ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-14T09:56:18.390031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.034837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-14T09:56:18.390069Z","caller":"traceutil/trace.go:171","msg":"trace[985987604] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2687; }","duration":"323.13897ms","start":"2026-04-14T09:56:18.06692Z","end":"2026-04-14T09:56:18.390059Z","steps":["trace[985987604] 'agreement among raft nodes before linearized reading'  (duration: 323.033607ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:56:18.390108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T09:56:18.066899Z","time spent":"323.200612ms","remote":"127.0.0.1:44166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "}
{"level":"warn","ts":"2026-04-14T09:56:18.390454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.945365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-04-14T09:56:18.390492Z","caller":"traceutil/trace.go:171","msg":"trace[807382758] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2687; }","duration":"211.035258ms","start":"2026-04-14T09:56:18.179447Z","end":"2026-04-14T09:56:18.390483Z","steps":["trace[807382758] 'agreement among raft nodes before linearized reading'  (duration: 210.906865ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T09:56:18.390472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.79007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18a6309dffa79315\" ","response":"range_response_count:1 size:777"}
{"level":"info","ts":"2026-04-14T09:56:18.390546Z","caller":"traceutil/trace.go:171","msg":"trace[1093507097] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18a6309dffa79315; range_end:; response_count:1; response_revision:2687; }","duration":"186.941884ms","start":"2026-04-14T09:56:18.203587Z","end":"2026-04-14T09:56:18.390528Z","steps":["trace[1093507097] 'agreement among raft nodes before linearized reading'  (duration: 186.709738ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T09:56:18.390886Z","caller":"traceutil/trace.go:171","msg":"trace[1994078586] transaction","detail":"{read_only:false; response_revision:2687; number_of_response:1; }","duration":"345.893275ms","start":"2026-04-14T09:56:18.044979Z","end":"2026-04-14T09:56:18.390872Z","steps":["trace[1994078586] 'process raft request'  (duration: 333.622738ms)","trace[1994078586] 'compare'  (duration: 11.111711ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-14T09:56:18.390996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T09:56:18.044964Z","time spent":"345.961386ms","remote":"127.0.0.1:43950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2675 > 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-04-14T09:59:58.529766Z","caller":"traceutil/trace.go:171","msg":"trace[646630836] transaction","detail":"{read_only:false; response_revision:4573; number_of_response:1; }","duration":"103.157694ms","start":"2026-04-14T09:59:58.426581Z","end":"2026-04-14T09:59:58.529739Z","steps":["trace[646630836] 'process raft request'  (duration: 77.735939ms)","trace[646630836] 'compare'  (duration: 24.911742ms)"],"step_count":2}
{"level":"info","ts":"2026-04-14T10:00:03.64243Z","caller":"traceutil/trace.go:171","msg":"trace[1244102249] transaction","detail":"{read_only:false; response_revision:4701; number_of_response:1; }","duration":"116.896631ms","start":"2026-04-14T10:00:03.525499Z","end":"2026-04-14T10:00:03.642396Z","steps":["trace[1244102249] 'process raft request'  (duration: 113.506639ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T10:00:19.135992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.725821ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8397416202275814511 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" mod_revision:4637 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" value_size:829 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-14T10:00:19.136252Z","caller":"traceutil/trace.go:171","msg":"trace[1639336215] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"405.434783ms","start":"2026-04-14T10:00:18.730795Z","end":"2026-04-14T10:00:19.136229Z","steps":["trace[1639336215] 'process raft request'  (duration: 44.367535ms)","trace[1639336215] 'compare'  (duration: 360.547416ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-14T10:00:19.136336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:00:18.730776Z","time spent":"405.520666ms","remote":"127.0.0.1:43856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" mod_revision:4637 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" value_size:829 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" > >"}
{"level":"info","ts":"2026-04-14T10:00:19.136504Z","caller":"traceutil/trace.go:171","msg":"trace[1491765345] transaction","detail":"{read_only:false; response_revision:4898; number_of_response:1; }","duration":"393.933417ms","start":"2026-04-14T10:00:18.742504Z","end":"2026-04-14T10:00:19.136437Z","steps":["trace[1491765345] 'process raft request'  (duration: 393.662161ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T10:00:19.136599Z","caller":"traceutil/trace.go:171","msg":"trace[454350889] transaction","detail":"{read_only:false; response_revision:4897; number_of_response:1; }","duration":"394.101721ms","start":"2026-04-14T10:00:18.742448Z","end":"2026-04-14T10:00:19.136549Z","steps":["trace[454350889] 'process raft request'  (duration: 393.65611ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T10:00:19.136737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:00:18.74248Z","time spent":"394.140593ms","remote":"127.0.0.1:43962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1429,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-keystone-hkkqm\" mod_revision:4641 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-hkkqm\" value_size:1363 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-hkkqm\" > >"}
{"level":"info","ts":"2026-04-14T10:00:19.137024Z","caller":"traceutil/trace.go:171","msg":"trace[1389871361] transaction","detail":"{read_only:false; response_revision:4899; number_of_response:1; }","duration":"394.47172ms","start":"2026-04-14T10:00:18.742539Z","end":"2026-04-14T10:00:19.13701Z","steps":["trace[1389871361] 'process raft request'  (duration: 393.788204ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T10:00:19.137012Z","caller":"traceutil/trace.go:171","msg":"trace[2132282082] linearizableReadLoop","detail":"{readStateIndex:5079; appliedIndex:5075; }","duration":"381.95463ms","start":"2026-04-14T10:00:18.755027Z","end":"2026-04-14T10:00:19.136981Z","steps":["trace[2132282082] 'read index received'  (duration: 20.108053ms)","trace[2132282082] 'applied index is now lower than readState.Index'  (duration: 361.845147ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-14T10:00:19.137106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:00:18.742529Z","time spent":"394.537682ms","remote":"127.0.0.1:43962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-xd5nk\" mod_revision:4633 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-xd5nk\" value_size:1434 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-xd5nk\" > >"}
{"level":"warn","ts":"2026-04-14T10:00:19.137256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.213856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-04-14T10:00:19.137309Z","caller":"traceutil/trace.go:171","msg":"trace[1263090973] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4899; }","duration":"382.280697ms","start":"2026-04-14T10:00:18.755011Z","end":"2026-04-14T10:00:19.137292Z","steps":["trace[1263090973] 'agreement among raft nodes before linearized reading'  (duration: 382.076623ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-14T10:00:19.137353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:00:18.754968Z","time spent":"382.373001ms","remote":"127.0.0.1:43848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "}
{"level":"warn","ts":"2026-04-14T10:00:19.138373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-14T10:00:18.742421Z","time spent":"394.386528ms","remote":"127.0.0.1:43856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":951,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" mod_revision:4632 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" value_size:881 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" > >"}
{"level":"info","ts":"2026-04-14T10:02:07.258087Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2944}
{"level":"info","ts":"2026-04-14T10:02:07.338968Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2944,"took":"78.427949ms","hash":747820091,"current-db-size-bytes":53809152,"current-db-size":"54 MB","current-db-size-in-use-bytes":29470720,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-04-14T10:02:07.339042Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":747820091,"revision":2944,"compact-revision":-1}
{"level":"info","ts":"2026-04-14T10:04:39.847907Z","caller":"traceutil/trace.go:171","msg":"trace[991918671] transaction","detail":"{read_only:false; response_revision:6752; number_of_response:1; }","duration":"103.52681ms","start":"2026-04-14T10:04:39.744277Z","end":"2026-04-14T10:04:39.847804Z","steps":["trace[991918671] 'process raft request'  (duration: 103.093521ms)"],"step_count":1}
{"level":"info","ts":"2026-04-14T10:07:07.264616Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5719}
{"level":"info","ts":"2026-04-14T10:07:07.382027Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5719,"took":"115.697901ms","hash":1070415772,"current-db-size-bytes":53809152,"current-db-size":"54 MB","current-db-size-in-use-bytes":18558976,"current-db-size-in-use":"19 MB"}
{"level":"info","ts":"2026-04-14T10:07:07.382109Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1070415772,"revision":5719,"compact-revision":2944}